builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-087 starttime: 1503449757.14 results: success (0) revision: 64a45ee1731c79da9850233a797bf80d3b1a52bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:57.144781) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:57.145235) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:57.145518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:57.156703) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:57.156960) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-22 17:55:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2017-08-22 17:55:57 (217 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138571 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:57.308375) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:57.308687) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015984 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:57.358739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:57.359172) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 64a45ee1731c79da9850233a797bf80d3b1a52bd --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 64a45ee1731c79da9850233a797bf80d3b1a52bd --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=ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-22 17:55:57,542 truncating revision to first 12 chars 2017-08-22 17:55:57,542 Setting DEBUG logging. 2017-08-22 17:55:57,542 attempt 1/10 2017-08-22 17:55:57,542 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/64a45ee1731c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-22 17:55:57,899 unpacking tar archive at: mozilla-central-64a45ee1731c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.699690 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:58.073212) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:58.073539) ========= script_repo_revision: 64a45ee1731c79da9850233a797bf80d3b1a52bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:58.073961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:58.074219) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 17:55:58.086062) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-22 17:55:58.086511) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:55:58 INFO - MultiFileLogger online at 20170822 17:55:58 in /builds/slave/test 17:55:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:55:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:55:58 INFO - {'append_to_log': False, 17:55:58 INFO - 'base_work_dir': '/builds/slave/test', 17:55:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:55:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:55:58 INFO - 'branch': 'Firefox-Non-PGO', 17:55:58 INFO - 'buildbot_json_path': 'buildprops.json', 17:55:58 INFO - 'code_coverage': False, 17:55:58 INFO - 'config_files': ('talos/linux_config.py',), 17:55:58 INFO - 'default_actions': ('clobber', 17:55:58 INFO - 'read-buildbot-config', 17:55:58 INFO - 'download-and-extract', 17:55:58 INFO - 'populate-webroot', 17:55:58 INFO - 'create-virtualenv', 17:55:58 INFO - 'install', 17:55:58 INFO - 'setup-mitmproxy', 17:55:58 INFO - 'run-tests'), 17:55:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:55:58 INFO - 'disable_ccov_upload': False, 17:55:58 INFO - 'download_minidump_stackwalk': True, 17:55:58 INFO - 'download_symbols': 'ondemand', 17:55:58 INFO - 'enable_stylo': False, 17:55:58 INFO - 'enable_webrender': False, 17:55:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:55:58 INFO - 'tooltool.py': '/tools/tooltool.py', 17:55:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:55:58 INFO - '/tools/misc-python/virtualenv.py')}, 17:55:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:55:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:55:58 INFO - 'gecko_profile': False, 17:55:58 INFO - 'gecko_profile_interval': 0, 17:55:58 INFO - 'installer_path': 'installer.exe', 17:55:58 INFO - 'log_level': 'info', 17:55:58 INFO - 'log_name': 'talos', 17:55:58 INFO - 'log_to_console': True, 17:55:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:55:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:55:58 INFO - 'opt_config_files': (), 17:55:58 INFO - 'pip_index': False, 17:55:58 INFO - 'suite': 'dromaeojs-e10s', 17:55:58 INFO - 'system_bits': '32', 17:55:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:55:58 INFO - 'title': 'talos-linux64-ix-087', 17:55:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:55:58 INFO - 'use_talos_json': True, 17:55:58 INFO - 'verify': 'False', 17:55:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:55:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:55:58 INFO - 'work_dir': 'build'} 17:55:58 INFO - [mozharness: 2017-08-23 00:55:58.407208Z] Running clobber step. 17:55:58 INFO - Running pre-action listener: _resource_record_pre_action 17:55:58 INFO - Running main action method: clobber 17:55:58 INFO - rmtree: /builds/slave/test/build 17:55:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:55:59 INFO - Running post-action listener: _resource_record_post_action 17:55:59 INFO - [mozharness: 2017-08-23 00:55:59.434500Z] Finished clobber step (success) 17:55:59 INFO - [mozharness: 2017-08-23 00:55:59.434596Z] Running read-buildbot-config step. 17:55:59 INFO - Running pre-action listener: _resource_record_pre_action 17:55:59 INFO - Running main action method: read_buildbot_config 17:55:59 INFO - Using buildbot properties: 17:55:59 INFO - { 17:55:59 INFO - "project": "", 17:55:59 INFO - "product": "firefox", 17:55:59 INFO - "who": "kwierso@gmail.com", 17:55:59 INFO - "installer_path": "public/build/target.tar.bz2", 17:55:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:55:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:55:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:55:59 INFO - "stage_platform": "linux64", 17:55:59 INFO - "basedir": "/builds/slave/test", 17:55:59 INFO - "buildnumber": 1093, 17:55:59 INFO - "platform": "ubuntu64_hw", 17:55:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:55:59 INFO - "slavebuilddir": "test", 17:55:59 INFO - "taskId": "JZzsNXgqSuOIEFGMaUSGaQ", 17:55:59 INFO - "branch": "mozilla-central", 17:55:59 INFO - "script_repo_revision": "production", 17:55:59 INFO - "revision": "64a45ee1731c79da9850233a797bf80d3b1a52bd", 17:55:59 INFO - "slavename": "talos-linux64-ix-087", 17:55:59 INFO - "repo_path": "mozilla-central" 17:55:59 INFO - } 17:55:59 INFO - Finding installer, test and symbols from parent task. 17:55:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JZzsNXgqSuOIEFGMaUSGaQ'}, attempt #1 17:55:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JZzsNXgqSuOIEFGMaUSGaQ'}, attempt #1 17:56:00 INFO - Task dependencies: IbzxS1zGRz6yU7eidXiiKg 17:56:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg'}, attempt #1 17:56:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.tar.bz2 17:56:00 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.test_packages.json 17:56:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.crashreporter-symbols.zip 17:56:00 INFO - Running post-action listener: _resource_record_post_action 17:56:00 INFO - [mozharness: 2017-08-23 00:56:00.782332Z] Finished read-buildbot-config step (success) 17:56:00 INFO - [mozharness: 2017-08-23 00:56:00.782553Z] Running download-and-extract step. 17:56:00 INFO - Running pre-action listener: _resource_record_pre_action 17:56:00 INFO - Running main action method: download_and_extract 17:56:00 INFO - mkdir: /builds/slave/test/build/tests 17:56: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')]} 17:56:00 INFO - trying https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.test_packages.json 17:56:00 INFO - Downloading https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:56:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:56:01 INFO - Downloaded 989 bytes. 17:56:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:56:01 INFO - Using the following test package requirements: 17:56:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:56:01 INFO - u'common': [u'target.common.tests.zip'], 17:56:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:56:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:56:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:56:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:56:01 INFO - u'mozbase': [u'target.common.tests.zip'], 17:56:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:56:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:56:01 INFO - u'web-platform': [u'target.common.tests.zip', 17:56:01 INFO - u'target.web-platform.tests.tar.gz'], 17:56:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:56:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:56:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.common.tests.zip 17:56:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:56:01 INFO - Fetch https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.common.tests.zip into memory 17:56:02 INFO - Content-Length response header: 54949654 17:56:02 INFO - Bytes received: 54949654 17:56:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:56:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.common.tests.zip 17:56:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:56:13 INFO - Fetch https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.common.tests.zip into memory 17:56:14 INFO - Content-Length response header: 54949654 17:56:14 INFO - Bytes received: 54949654 17:56:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.talos.tests.zip 17:56:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:56:26 INFO - Fetch https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.talos.tests.zip into memory 17:56:27 INFO - Content-Length response header: 14496256 17:56:27 INFO - Bytes received: 14496256 17:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:27 INFO - trying https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.tar.bz2 17:56:27 INFO - Downloading https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:56:28 INFO - Downloaded 61179682 bytes. 17:56:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.tar.bz2 17:56:28 INFO - mkdir: /builds/slave/test/properties 17:56:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:56:28 INFO - Writing to file /builds/slave/test/properties/build_url 17:56:28 INFO - Contents: 17:56:28 INFO - build_url:https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.tar.bz2 17:56:28 INFO - Running post-action listener: _resource_record_post_action 17:56:28 INFO - Running post-action listener: find_tests_for_verification 17:56:28 INFO - Running post-action listener: set_extra_try_arguments 17:56:28 INFO - [mozharness: 2017-08-23 00:56:28.769505Z] Finished download-and-extract step (success) 17:56:28 INFO - [mozharness: 2017-08-23 00:56:28.769602Z] Running populate-webroot step. 17:56:28 INFO - Running pre-action listener: _resource_record_pre_action 17:56:28 INFO - Running main action method: populate_webroot 17:56:28 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:56:28 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 17:56:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:56:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:56:28 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 17:56:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:56:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:56:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:28 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:28 INFO - 'talos_options': ['--stylo'], 17:56:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:56:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:56:28 INFO - 'tests': ['damp', 'tps']}, 17:56:28 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:28 INFO - 'talos_options': ['--stylo'], 17:56:28 INFO - 'tests': ['damp', 'tps']}, 17:56:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:56:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:56:28 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 17:56:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:56:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:56:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:56:28 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:28 INFO - 'talos_options': ['--stylo'], 17:56:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:56:28 INFO - 'other-e10s': {'tests': ['a11yr', 17:56:28 INFO - 'ts_paint', 17:56:28 INFO - 'tpaint', 17:56:28 INFO - 'sessionrestore', 17:56:28 INFO - 'sessionrestore_many_windows', 17:56:28 INFO - 'sessionrestore_no_auto_restore', 17:56:28 INFO - 'tabpaint']}, 17:56:28 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 17:56:28 INFO - 'tests': ['a11yr', 17:56:28 INFO - 'ts_paint', 17:56:28 INFO - 'tpaint', 17:56:28 INFO - 'sessionrestore', 17:56:28 INFO - 'sessionrestore_many_windows', 17:56:28 INFO - 'sessionrestore_no_auto_restore', 17:56:28 INFO - 'tabpaint']}, 17:56:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:56:28 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:56:28 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 17:56:28 INFO - 'tests': ['bloom_basic_singleton']}, 17:56:28 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 17:56:28 INFO - 'tests': ['bloom_basic']}, 17:56:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:56:28 INFO - 'tsvgr_opacity', 17:56:28 INFO - 'tart', 17:56:28 INFO - 'tscrollx', 17:56:28 INFO - 'tsvg_static']}, 17:56:28 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 17:56:28 INFO - 'tests': ['tsvgx', 17:56:28 INFO - 'tsvgr_opacity', 17:56:28 INFO - 'tart', 17:56:28 INFO - 'tscrollx', 17:56:28 INFO - 'tsvg_static']}, 17:56:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:56:28 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:28 INFO - 'talos_options': ['--stylo'], 17:56:28 INFO - 'tests': ['tp5o']}, 17:56:28 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:56:28 INFO - 'talos_options': ['--mitmproxy', 17:56:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:56:28 INFO - '--firstNonBlankPaint'], 17:56:28 INFO - 'tests': ['tp6_google', 17:56:28 INFO - 'tp6_youtube', 17:56:28 INFO - 'tp6_amazon', 17:56:28 INFO - 'tp6_facebook']}, 17:56:28 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:56:28 INFO - 'talos_options': ['--stylo', 17:56:28 INFO - '--mitmproxy', 17:56:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:56:28 INFO - '--firstNonBlankPaint'], 17:56:28 INFO - 'tests': ['tp6_google', 17:56:28 INFO - 'tp6_youtube', 17:56:28 INFO - 'tp6_amazon', 17:56:28 INFO - 'tp6_facebook']}, 17:56:28 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:56:28 INFO - 'talos_options': ['--stylo', 17:56:28 INFO - '--stylo-threads=1', 17:56:28 INFO - '--mitmproxy', 17:56:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:56:28 INFO - '--firstNonBlankPaint'], 17:56:28 INFO - 'tests': ['tp6_google', 17:56:28 INFO - 'tp6_youtube', 17:56:28 INFO - 'tp6_amazon', 17:56:28 INFO - 'tp6_facebook']}, 17:56:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:56:28 INFO - 'talos_options': ['--xperf_path', 17:56:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:28 INFO - 'tests': ['tp5n']}, 17:56:28 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:56:28 INFO - 'talos_options': ['--stylo', 17:56:28 INFO - '--xperf_path', 17:56:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:56:28 INFO - 'tests': ['tp5n']}}} 17:56:28 INFO - Running post-action listener: _resource_record_post_action 17:56:28 INFO - [mozharness: 2017-08-23 00:56:28.783781Z] Finished populate-webroot step (success) 17:56:28 INFO - [mozharness: 2017-08-23 00:56:28.783871Z] Running create-virtualenv step. 17:56:28 INFO - Running pre-action listener: _resource_record_pre_action 17:56:28 INFO - Running main action method: create_virtualenv 17:56:28 INFO - Creating virtualenv /builds/slave/test/build/venv 17:56:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:56:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:56:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:56:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:56:28 INFO - Using real prefix '/usr' 17:56:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:56:29 INFO - Installing distribute.............................................................................................................................................................................................done. 17:56:31 INFO - Installing pip.................done. 17:56:31 INFO - Return code: 0 17:56:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:56:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:56:31 INFO - Reading from file tmpfile_stdout 17:56:31 INFO - Output received: 17:56:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:56:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:31 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 0xa4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8130>, '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 0xdb9030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb94c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:31 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 17:56:31 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 17:56:31 INFO - Using env: {'DISPLAY': ':0', 17:56:31 INFO - 'HOME': '/home/cltbld', 17:56:31 INFO - 'LANG': 'en_US.UTF-8', 17:56:31 INFO - 'LANGUAGE': 'en_US:en', 17:56:31 INFO - 'LOGNAME': 'cltbld', 17:56:31 INFO - 'MAIL': '/var/mail/cltbld', 17:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:31 INFO - 'MOZ_NO_REMOTE': '1', 17:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:31 INFO - 'NO_EM_RESTART': '1', 17:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:31 INFO - 'PWD': '/builds/slave/test', 17:56:31 INFO - 'SHELL': '/bin/bash', 17:56:31 INFO - 'SHLVL': '1', 17:56:31 INFO - 'TERM': 'linux', 17:56:31 INFO - 'TMOUT': '86400', 17:56:31 INFO - 'USER': 'cltbld', 17:56:31 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 17:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:31 INFO - '_': '/tools/buildbot/bin/python'} 17:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:56:31 INFO - Cleaning up... 17:56:31 INFO - Return code: 0 17:56:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:31 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 0xa4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8130>, '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 0xdb9030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb94c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:31 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 17:56:31 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 17:56:31 INFO - Using env: {'DISPLAY': ':0', 17:56:31 INFO - 'HOME': '/home/cltbld', 17:56:31 INFO - 'LANG': 'en_US.UTF-8', 17:56:31 INFO - 'LANGUAGE': 'en_US:en', 17:56:31 INFO - 'LOGNAME': 'cltbld', 17:56:31 INFO - 'MAIL': '/var/mail/cltbld', 17:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:31 INFO - 'MOZ_NO_REMOTE': '1', 17:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:31 INFO - 'NO_EM_RESTART': '1', 17:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:31 INFO - 'PWD': '/builds/slave/test', 17:56:31 INFO - 'SHELL': '/bin/bash', 17:56:31 INFO - 'SHLVL': '1', 17:56:31 INFO - 'TERM': 'linux', 17:56:31 INFO - 'TMOUT': '86400', 17:56:31 INFO - 'USER': 'cltbld', 17:56:31 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 17:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:31 INFO - '_': '/tools/buildbot/bin/python'} 17:56:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:32 INFO - Downloading/unpacking psutil>=3.1.1 17:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:56:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:33 INFO - Installing collected packages: psutil 17:56:33 INFO - Running setup.py install for psutil 17:56:33 INFO - building 'psutil._psutil_linux' extension 17:56:33 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 17:56:33 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 17:56:33 INFO - building 'psutil._psutil_posix' extension 17:56:33 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 17:56:33 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 17:56:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:56:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:56:33 INFO - Successfully installed psutil 17:56:33 INFO - Cleaning up... 17:56:33 INFO - Return code: 0 17:56:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:56: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')]} 17:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56: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')]} 17:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:33 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 0xa4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8130>, '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 0xdb9030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb94c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:33 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 17:56:33 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 17:56:33 INFO - Using env: {'DISPLAY': ':0', 17:56:33 INFO - 'HOME': '/home/cltbld', 17:56:33 INFO - 'LANG': 'en_US.UTF-8', 17:56:33 INFO - 'LANGUAGE': 'en_US:en', 17:56:33 INFO - 'LOGNAME': 'cltbld', 17:56:33 INFO - 'MAIL': '/var/mail/cltbld', 17:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:33 INFO - 'MOZ_NO_REMOTE': '1', 17:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:33 INFO - 'NO_EM_RESTART': '1', 17:56:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:33 INFO - 'PWD': '/builds/slave/test', 17:56:33 INFO - 'SHELL': '/bin/bash', 17:56:33 INFO - 'SHLVL': '1', 17:56:33 INFO - 'TERM': 'linux', 17:56:33 INFO - 'TMOUT': '86400', 17:56:33 INFO - 'USER': 'cltbld', 17:56:33 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 17:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:33 INFO - '_': '/tools/buildbot/bin/python'} 17:56:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:56:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:56:35 INFO - Installing collected packages: mozsystemmonitor 17:56:35 INFO - Running setup.py install for mozsystemmonitor 17:56:35 INFO - Successfully installed mozsystemmonitor 17:56:35 INFO - Cleaning up... 17:56:35 INFO - Return code: 0 17:56:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:35 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 0xa4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8130>, '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 0xdb9030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb94c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:35 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 17:56:35 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 17:56:35 INFO - Using env: {'DISPLAY': ':0', 17:56:35 INFO - 'HOME': '/home/cltbld', 17:56:35 INFO - 'LANG': 'en_US.UTF-8', 17:56:35 INFO - 'LANGUAGE': 'en_US:en', 17:56:35 INFO - 'LOGNAME': 'cltbld', 17:56:35 INFO - 'MAIL': '/var/mail/cltbld', 17:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:35 INFO - 'MOZ_NO_REMOTE': '1', 17:56:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:35 INFO - 'NO_EM_RESTART': '1', 17:56:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:35 INFO - 'PWD': '/builds/slave/test', 17:56:35 INFO - 'SHELL': '/bin/bash', 17:56:35 INFO - 'SHLVL': '1', 17:56:35 INFO - 'TERM': 'linux', 17:56:35 INFO - 'TMOUT': '86400', 17:56:35 INFO - 'USER': 'cltbld', 17:56:35 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 17:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:35 INFO - '_': '/tools/buildbot/bin/python'} 17:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:35 INFO - Downloading/unpacking jsonschema==2.5.1 17:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:56:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:36 INFO - Downloading functools32-3.2.3-2.tar.gz 17:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:56:36 INFO - warning: no files found matching '*.txt' 17:56:36 INFO - no previously-included directories found matching 'build' 17:56:36 INFO - no previously-included directories found matching 'dist' 17:56:36 INFO - no previously-included directories found matching '.git*' 17:56:36 INFO - Installing collected packages: jsonschema, functools32 17:56:36 INFO - Running setup.py install for functools32 17:56:36 INFO - warning: no files found matching '*.txt' 17:56:36 INFO - no previously-included directories found matching 'build' 17:56:36 INFO - no previously-included directories found matching 'dist' 17:56:36 INFO - no previously-included directories found matching '.git*' 17:56:36 INFO - Successfully installed jsonschema functools32 17:56:36 INFO - Cleaning up... 17:56:36 INFO - Return code: 0 17:56:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:36 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 0xa4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8130>, '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 0xdb9030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb94c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:36 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 17:56:36 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 17:56:36 INFO - Using env: {'DISPLAY': ':0', 17:56:36 INFO - 'HOME': '/home/cltbld', 17:56:36 INFO - 'LANG': 'en_US.UTF-8', 17:56:36 INFO - 'LANGUAGE': 'en_US:en', 17:56:36 INFO - 'LOGNAME': 'cltbld', 17:56:36 INFO - 'MAIL': '/var/mail/cltbld', 17:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:36 INFO - 'MOZ_NO_REMOTE': '1', 17:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:36 INFO - 'NO_EM_RESTART': '1', 17:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:36 INFO - 'PWD': '/builds/slave/test', 17:56:36 INFO - 'SHELL': '/bin/bash', 17:56:36 INFO - 'SHLVL': '1', 17:56:36 INFO - 'TERM': 'linux', 17:56:36 INFO - 'TMOUT': '86400', 17:56:36 INFO - 'USER': 'cltbld', 17:56:36 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 17:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:36 INFO - '_': '/tools/buildbot/bin/python'} 17:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:56:37 INFO - Cleaning up... 17:56:37 INFO - Return code: 0 17:56:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:37 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 0xa4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8130>, '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 0xdb9030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb94c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:37 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 17:56:37 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 17:56:37 INFO - Using env: {'DISPLAY': ':0', 17:56:37 INFO - 'HOME': '/home/cltbld', 17:56:37 INFO - 'LANG': 'en_US.UTF-8', 17:56:37 INFO - 'LANGUAGE': 'en_US:en', 17:56:37 INFO - 'LOGNAME': 'cltbld', 17:56:37 INFO - 'MAIL': '/var/mail/cltbld', 17:56:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:37 INFO - 'MOZ_NO_REMOTE': '1', 17:56:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:37 INFO - 'NO_EM_RESTART': '1', 17:56:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:37 INFO - 'PWD': '/builds/slave/test', 17:56:37 INFO - 'SHELL': '/bin/bash', 17:56:37 INFO - 'SHLVL': '1', 17:56:37 INFO - 'TERM': 'linux', 17:56:37 INFO - 'TMOUT': '86400', 17:56:37 INFO - 'USER': 'cltbld', 17:56:37 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 17:56:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:37 INFO - '_': '/tools/buildbot/bin/python'} 17:56:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:37 INFO - Downloading/unpacking blobuploader==1.2.4 17:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:38 INFO - Downloading blobuploader-1.2.4.tar.gz 17:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:56:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:56:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:39 INFO - Downloading docopt-0.6.1.tar.gz 17:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:56:39 INFO - Installing collected packages: blobuploader, requests, docopt 17:56:39 INFO - Running setup.py install for blobuploader 17:56:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:56:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:56:39 INFO - Running setup.py install for requests 17:56:39 INFO - Running setup.py install for docopt 17:56:39 INFO - Successfully installed blobuploader requests docopt 17:56:39 INFO - Cleaning up... 17:56:39 INFO - Return code: 0 17:56:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:39 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 0xa4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8130>, '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 0xdb9030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb94c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:56:39 INFO - Using env: {'DISPLAY': ':0', 17:56:39 INFO - 'HOME': '/home/cltbld', 17:56:39 INFO - 'LANG': 'en_US.UTF-8', 17:56:39 INFO - 'LANGUAGE': 'en_US:en', 17:56:39 INFO - 'LOGNAME': 'cltbld', 17:56:39 INFO - 'MAIL': '/var/mail/cltbld', 17:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:39 INFO - 'MOZ_NO_REMOTE': '1', 17:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:39 INFO - 'NO_EM_RESTART': '1', 17:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:39 INFO - 'PWD': '/builds/slave/test', 17:56:39 INFO - 'SHELL': '/bin/bash', 17:56:39 INFO - 'SHLVL': '1', 17:56:39 INFO - 'TERM': 'linux', 17:56:39 INFO - 'TMOUT': '86400', 17:56:39 INFO - 'USER': 'cltbld', 17:56:39 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 17:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:39 INFO - '_': '/tools/buildbot/bin/python'} 17:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:39 INFO - Running setup.py (path:/tmp/pip-_kt8qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:40 INFO - Running setup.py (path:/tmp/pip-dN3_NK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:40 INFO - Running setup.py (path:/tmp/pip-aa06nC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:40 INFO - Running setup.py (path:/tmp/pip-9vSWCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:40 INFO - Running setup.py (path:/tmp/pip-GNhNyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:40 INFO - Running setup.py (path:/tmp/pip-C4Ey9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:40 INFO - Running setup.py (path:/tmp/pip-lp6KCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:40 INFO - Running setup.py (path:/tmp/pip-mxDoqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:40 INFO - Running setup.py (path:/tmp/pip-u4D2pi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:40 INFO - Running setup.py (path:/tmp/pip-713wT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:40 INFO - Running setup.py (path:/tmp/pip-llJfM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:40 INFO - Running setup.py (path:/tmp/pip-Ce4exm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:40 INFO - Running setup.py (path:/tmp/pip-CuqqY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:40 INFO - Running setup.py (path:/tmp/pip-jIrU1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:40 INFO - Running setup.py (path:/tmp/pip-puGMXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:41 INFO - Running setup.py (path:/tmp/pip-gkf_83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:41 INFO - Running setup.py (path:/tmp/pip-yzfp0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:56:41 INFO - Running setup.py install for manifestparser 17:56:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:56:41 INFO - Running setup.py install for mozcrash 17:56:41 INFO - Running setup.py install for mozdebug 17:56:41 INFO - Running setup.py install for mozdevice 17:56:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:56:41 INFO - Running setup.py install for mozfile 17:56:41 INFO - Running setup.py install for mozhttpd 17:56:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:56:41 INFO - Running setup.py install for mozinfo 17:56:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:56:41 INFO - Running setup.py install for mozInstall 17:56:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:56:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:56:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:56:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:56:41 INFO - Running setup.py install for mozleak 17:56:42 INFO - Running setup.py install for mozlog 17:56:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:56:42 INFO - Running setup.py install for moznetwork 17:56:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:56:42 INFO - Running setup.py install for mozprocess 17:56:42 INFO - Running setup.py install for mozprofile 17:56:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:56:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:56:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:56:42 INFO - Running setup.py install for mozrunner 17:56:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:56:42 INFO - Running setup.py install for mozscreenshot 17:56:42 INFO - Running setup.py install for moztest 17:56:42 INFO - Running setup.py install for mozversion 17:56:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:56:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:56:42 INFO - Cleaning up... 17:56:42 INFO - Return code: 0 17:56:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:42 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 0xa4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8130>, '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 0xdb9030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb94c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:56:42 INFO - Using env: {'DISPLAY': ':0', 17:56:42 INFO - 'HOME': '/home/cltbld', 17:56:42 INFO - 'LANG': 'en_US.UTF-8', 17:56:42 INFO - 'LANGUAGE': 'en_US:en', 17:56:42 INFO - 'LOGNAME': 'cltbld', 17:56:42 INFO - 'MAIL': '/var/mail/cltbld', 17:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:42 INFO - 'MOZ_NO_REMOTE': '1', 17:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:42 INFO - 'NO_EM_RESTART': '1', 17:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:42 INFO - 'PWD': '/builds/slave/test', 17:56:42 INFO - 'SHELL': '/bin/bash', 17:56:42 INFO - 'SHLVL': '1', 17:56:42 INFO - 'TERM': 'linux', 17:56:42 INFO - 'TMOUT': '86400', 17:56:42 INFO - 'USER': 'cltbld', 17:56:42 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 17:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:42 INFO - '_': '/tools/buildbot/bin/python'} 17:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:56:43 INFO - Running setup.py (path:/tmp/pip-0HZPYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:56:43 INFO - Running setup.py (path:/tmp/pip-jc3Lwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:56:43 INFO - Running setup.py (path:/tmp/pip-cpEQ9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:56:43 INFO - Running setup.py (path:/tmp/pip-GtuUih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:56:43 INFO - Running setup.py (path:/tmp/pip-UhqynZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:56:43 INFO - Running setup.py (path:/tmp/pip-VCrlOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:56:43 INFO - Running setup.py (path:/tmp/pip-wPKXUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:56:43 INFO - Running setup.py (path:/tmp/pip-94mCOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:56:43 INFO - Running setup.py (path:/tmp/pip-34zDmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:56:43 INFO - Running setup.py (path:/tmp/pip-kZwMpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:56:43 INFO - Running setup.py (path:/tmp/pip-pCkGDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:56:43 INFO - Running setup.py (path:/tmp/pip-65ELRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:56:44 INFO - Running setup.py (path:/tmp/pip-HKBGwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:56:44 INFO - Running setup.py (path:/tmp/pip-kkYhAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:44 INFO - Running setup.py (path:/tmp/pip-Y0dCDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:56:44 INFO - Running setup.py (path:/tmp/pip-POFz4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:56:44 INFO - Running setup.py (path:/tmp/pip-IwUZA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:56:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:45 INFO - Downloading blessings-1.6.tar.gz 17:56:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:56:45 INFO - Installing collected packages: blessings 17:56:45 INFO - Running setup.py install for blessings 17:56:45 INFO - Successfully installed blessings 17:56:45 INFO - Cleaning up... 17:56:45 INFO - Return code: 0 17:56:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:56:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:45 INFO - Reading from file tmpfile_stdout 17:56:45 INFO - Current package versions: 17:56:45 INFO - argparse == 1.2.1 17:56:45 INFO - blessings == 1.6 17:56:45 INFO - blobuploader == 1.2.4 17:56:45 INFO - docopt == 0.6.1 17:56:45 INFO - functools32 == 3.2.3-2 17:56:45 INFO - jsonschema == 2.5.1 17:56:45 INFO - manifestparser == 1.1 17:56:45 INFO - mozInstall == 1.13 17:56:45 INFO - mozcrash == 1.0 17:56:45 INFO - mozdebug == 0.1 17:56:45 INFO - mozdevice == 0.51 17:56:45 INFO - mozfile == 1.2 17:56:45 INFO - mozhttpd == 0.7 17:56:45 INFO - mozinfo == 0.10 17:56:45 INFO - mozleak == 0.1 17:56:45 INFO - mozlog == 3.5 17:56:45 INFO - moznetwork == 0.27 17:56:45 INFO - mozprocess == 0.25 17:56:45 INFO - mozprofile == 0.28 17:56:45 INFO - mozrunner == 6.13 17:56:45 INFO - mozscreenshot == 0.1 17:56:45 INFO - mozsystemmonitor == 0.3 17:56:45 INFO - moztest == 0.8 17:56:45 INFO - mozversion == 1.4 17:56:45 INFO - psutil == 3.1.1 17:56:45 INFO - requests == 1.2.3 17:56:45 INFO - wsgiref == 0.1.2 17:56:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:45 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 0xa4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8130>, '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 0xdb9030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb94c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:56:45 INFO - Using env: {'DISPLAY': ':0', 17:56:45 INFO - 'HOME': '/home/cltbld', 17:56:45 INFO - 'LANG': 'en_US.UTF-8', 17:56:45 INFO - 'LANGUAGE': 'en_US:en', 17:56:45 INFO - 'LOGNAME': 'cltbld', 17:56:45 INFO - 'MAIL': '/var/mail/cltbld', 17:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:45 INFO - 'MOZ_NO_REMOTE': '1', 17:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:45 INFO - 'NO_EM_RESTART': '1', 17:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:45 INFO - 'PWD': '/builds/slave/test', 17:56:45 INFO - 'SHELL': '/bin/bash', 17:56:45 INFO - 'SHLVL': '1', 17:56:45 INFO - 'TERM': 'linux', 17:56:45 INFO - 'TMOUT': '86400', 17:56:45 INFO - 'USER': 'cltbld', 17:56:45 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 17:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:45 INFO - '_': '/tools/buildbot/bin/python'} 17:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:56:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:56:46 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:56:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:56:47 INFO - Installing collected packages: simplejson 17:56:47 INFO - Running setup.py install for simplejson 17:56:47 INFO - building 'simplejson._speedups' extension 17:56:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 17:56:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 17:56:48 INFO - Successfully installed simplejson 17:56:48 INFO - Cleaning up... 17:56:48 INFO - Return code: 0 17:56:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:56:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa4c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc17a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbaf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdb8130>, '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 0xdb9030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb94c0>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:56:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:56:48 INFO - Using env: {'DISPLAY': ':0', 17:56:48 INFO - 'HOME': '/home/cltbld', 17:56:48 INFO - 'LANG': 'en_US.UTF-8', 17:56:48 INFO - 'LANGUAGE': 'en_US:en', 17:56:48 INFO - 'LOGNAME': 'cltbld', 17:56:48 INFO - 'MAIL': '/var/mail/cltbld', 17:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:56:48 INFO - 'MOZ_NO_REMOTE': '1', 17:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:56:48 INFO - 'NO_EM_RESTART': '1', 17:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:56:48 INFO - 'PWD': '/builds/slave/test', 17:56:48 INFO - 'SHELL': '/bin/bash', 17:56:48 INFO - 'SHLVL': '1', 17:56:48 INFO - 'TERM': 'linux', 17:56:48 INFO - 'TMOUT': '86400', 17:56:48 INFO - 'USER': 'cltbld', 17:56:48 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 17:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:56:48 INFO - '_': '/tools/buildbot/bin/python'} 17:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:56:48 INFO - Cleaning up... 17:56:48 INFO - Return code: 0 17:56:48 INFO - Running post-action listener: _resource_record_post_action 17:56:48 INFO - Running post-action listener: _start_resource_monitoring 17:56:48 INFO - Starting resource monitoring. 17:56:48 INFO - [mozharness: 2017-08-23 00:56:48.654327Z] Finished create-virtualenv step (success) 17:56:48 INFO - [mozharness: 2017-08-23 00:56:48.654798Z] Running install step. 17:56:48 INFO - Running pre-action listener: _resource_record_pre_action 17:56:48 INFO - Running main action method: install 17:56:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:56:48 INFO - Reading from file tmpfile_stdout 17:56:48 INFO - Detecting whether we're running mozinstall >=1.0... 17:56:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:56:49 INFO - Reading from file tmpfile_stdout 17:56:49 INFO - Output received: 17:56:49 INFO - Usage: mozinstall [options] installer 17:56:49 INFO - Options: 17:56:49 INFO - -h, --help show this help message and exit 17:56:49 INFO - -d DEST, --destination=DEST 17:56:49 INFO - Directory to install application into. [default: 17:56:49 INFO - "/builds/slave/test"] 17:56:49 INFO - --app=APP Application being installed. [default: firefox] 17:56:49 INFO - mkdir: /builds/slave/test/build/application 17:56:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:57:06 INFO - Reading from file tmpfile_stdout 17:57:06 INFO - Output received: 17:57:06 INFO - /builds/slave/test/build/application/firefox/firefox 17:57:06 INFO - Running post-action listener: _resource_record_post_action 17:57:06 INFO - [mozharness: 2017-08-23 00:57:06.698625Z] Finished install step (success) 17:57:06 INFO - [mozharness: 2017-08-23 00:57:06.698907Z] Running setup-mitmproxy step. 17:57:06 INFO - Running pre-action listener: _resource_record_pre_action 17:57:06 INFO - Running main action method: setup_mitmproxy 17:57:06 INFO - Skipping: mitmproxy is not required 17:57:06 INFO - Running post-action listener: _resource_record_post_action 17:57:06 INFO - [mozharness: 2017-08-23 00:57:06.700040Z] Finished setup-mitmproxy step (success) 17:57:06 INFO - [mozharness: 2017-08-23 00:57:06.700258Z] Running run-tests step. 17:57:06 INFO - Running pre-action listener: _resource_record_pre_action 17:57:06 INFO - Running pre-action listener: _set_gcov_prefix 17:57:06 INFO - Running main action method: run_tests 17:57:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:57:06 INFO - Python 2.7.3 17:57:06 INFO - Return code: 0 17:57:06 INFO - grabbing minidump binary from tooltool 17: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')]} 17:57:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0xdb8130>, '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 0xdb9030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdb94c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:57:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:57:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:57:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:57:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:57:06 INFO - Return code: 0 17:57:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:57:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:57:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:57:06 INFO - ENV: RUST_BACKTRACE is now full 17:57:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:57:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:57:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 17:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --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 17:57:06 INFO - Using env: {'DISPLAY': ':0', 17:57:06 INFO - 'HOME': '/home/cltbld', 17:57:06 INFO - 'LANG': 'en_US.UTF-8', 17:57:06 INFO - 'LANGUAGE': 'en_US:en', 17:57:06 INFO - 'LOGNAME': 'cltbld', 17:57:06 INFO - 'MAIL': '/var/mail/cltbld', 17:57:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:57:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:57:06 INFO - 'MOZ_NO_REMOTE': '1', 17:57:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:57:06 INFO - 'NO_EM_RESTART': '1', 17:57:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:57:06 INFO - 'PWD': '/builds/slave/test', 17:57:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:57:06 INFO - 'RUST_BACKTRACE': 'full', 17:57:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:57:06 INFO - 'SHELL': '/bin/bash', 17:57:06 INFO - 'SHLVL': '1', 17:57:06 INFO - 'TERM': 'linux', 17:57:06 INFO - 'TMOUT': '86400', 17:57:06 INFO - 'USER': 'cltbld', 17:57:06 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724', 17:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:57:06 INFO - '_': '/tools/buildbot/bin/python'} 17:57:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 17:57:07 INFO - mozversion application_buildid: 20170823000740 17:57:07 INFO - mozversion application_changeset: 64a45ee1731c79da9850233a797bf80d3b1a52bd 17:57:07 INFO - mozversion application_display_name: Nightly 17:57:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:57:07 INFO - mozversion application_name: Firefox 17:57:07 INFO - mozversion application_remotingname: firefox 17:57:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:57:07 INFO - mozversion application_vendor: Mozilla 17:57:07 INFO - mozversion application_version: 57.0a1 17:57:07 INFO - mozversion platform_buildid: 20170823000740 17:57:07 INFO - mozversion platform_changeset: 64a45ee1731c79da9850233a797bf80d3b1a52bd 17:57:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:57:07 INFO - mozversion platform_version: 57.0a1 17:57:07 INFO - using testdate: 1503449827 17:57:07 INFO - actual date: 1503449827 17:57:07 INFO - starting webserver on 'localhost:49820' 17:57:07 INFO - SUITE-START | Running 2 tests 17:57:07 INFO - TEST-START | dromaeo_css 17:57:07 INFO - Initialising browser for dromaeo_css test... 17:57:07 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49820/getInfo.html -profile /tmp/tmplXQLlm/profile 17:57:07 INFO - TEST-INFO | started process 23386 (/builds/slave/test/build/application/firefox/firefox http://localhost:49820/getInfo.html) 17:57:13 INFO - TEST-INFO | 23386: exit 0 17:57:13 INFO - Browser initialized. 17:57:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:57:13 INFO - TEST-INFO | started process 23561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplXQLlm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:57:14 INFO - PID 23561 | 17:57:14 INFO - PID 23561 | (/builds/slave/test/build/application/firefox/firefox:23611): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:57:14 INFO - PID 23561 | 17:57:14 INFO - PID 23561 | 17:57:14 INFO - PID 23561 | (/builds/slave/test/build/application/firefox/firefox:23665): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:57:14 INFO - PID 23561 | 17:57:14 INFO - PID 23561 | __metrics Screen width/height:1600/1200 17:57:14 INFO - PID 23561 | colorDepth:24 17:57:14 INFO - PID 23561 | Browser inner width/height: 1024/768 17:57:14 INFO - PID 23561 | __metrics 17:57:24 INFO - PID 23561 | RSS: Main: 171642880 17:57:24 INFO - PID 23561 | 17:58:17 INFO - PID 23561 | [Parent 23561] WARNING: pipe error (116): Connection reset by peer: file /home/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 353 18:00:23 INFO - PID 23561 | Cycle 1(1): loaded http://localhost:49820/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49820/tests/dromaeo/cssquery-ext.html) 18:00:24 INFO - PID 23561 | RSS: Main: 176148480 18:00:24 INFO - PID 23561 | 18:03:26 INFO - PID 23561 | Cycle 1(1): loaded http://localhost:49820/tests/dromaeo/cssquery-ext.html (next: http://localhost:49820/tests/dromaeo/cssquery-jquery.html) 18:03:26 INFO - PID 23561 | RSS: Main: 173113344 18:03:26 INFO - PID 23561 | 18:06:28 INFO - PID 23561 | Cycle 1(1): loaded http://localhost:49820/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49820/tests/dromaeo/cssquery-mootools.html) 18:06:28 INFO - PID 23561 | RSS: Main: 174727168 18:06:28 INFO - PID 23561 | 18:09:30 INFO - PID 23561 | Cycle 1(1): loaded http://localhost:49820/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49820/tests/dromaeo/cssquery-prototype.html) 18:09:31 INFO - PID 23561 | RSS: Main: 173645824 18:09:31 INFO - PID 23561 | 18:12:35 INFO - PID 23561 | Cycle 1(1): loaded http://localhost:49820/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49820/tests/dromaeo/cssquery-yui.html) 18:12:35 INFO - PID 23561 | RSS: Main: 176910336 18:12:35 INFO - PID 23561 | 18:15:37 INFO - PID 23561 | Cycle 1(1): loaded http://localhost:49820/tests/dromaeo/cssquery-yui.html (next: http://localhost:49820/tests/dromaeo/cssquery-dojo.html) 18:15:37 INFO - PID 23561 | RSS: Main: 177999872 18:15:37 INFO - PID 23561 | 18:15:37 INFO - PID 23561 | __start_tp_report 18:15:37 INFO - PID 23561 | _x_x_mozilla_page_load 18:15:37 INFO - PID 23561 | _x_x_mozilla_page_load_details 18:15:37 INFO - PID 23561 | |i|pagename|runs| 18:15:37 INFO - PID 23561 | |0;dojo.html;3283.802971821691;3299.208190034392;3314.5028245763133;3318.0377690469763;3329.4007078725836;6179.814605561829;6223.471004964577;6280.403361680639;6296.6222026678315;6310.526710496714;6125.295591007036;6229.813105606839;6241.407066328703;6250.781222657208;6270.937290627093;5699.202111704365;5703.173039909221;5721.828345149652;5740.339860916007;5855.707214639272;5744.253247077874;5815.38938411467;5816.360200377955;5819.738111784959;5837.50381217597;5552.361478429992;5762.855928601776;5787.652740835563;5844.883102337972;5853.824385268449;5661;5679.119736440858;5714.114312281561;5749.511291540224;5798.1592669063175;5679.034564124109;5700.23046888673;5786.971065144689;5814.098814683731;5829.183914252008;6189.597676151081;6191.380861913818;6231.87536249277;6232.096346029845;6249.187605611287;6666.366695163952;6682.498812589075;6697.397234248892;6771.796846094625;6785.660716964181;6729.091572637681;6740.39336459721;6746.966265168643;6826.146731658543;6826.317368263183;6160.87678246437;6211.565190436671;6215.595986260879;6231.096491008823;6348.428641422294;6840.144981877265;6845.486588505882;6875.209350924608;6901.206361268418;6939.410150137194;6548.508861835381;6548.869022619521;6620;6633.204015518072;6657.733690652417;6689.531732778659;6709.094272273278;6749.460043196533;6769.120014398097;6796.592204467748;6550.737970481223;6555.278919318871;6645.235797883209;6647.169103862017;6708.8993665094085;6623.437007854386;6718.193816742022;6728.428083612947;6729.461643068543;6735.966320168368;5253.054450199001;5290.047791397586;5290.1800220965815;5296.470352964673;5318.069337865858;4586.839460618862;4605.171069207575;4614.446266448048;4636.235021221461;4641.210994130938;5791.536677065825;5873.794417195378;5880;5884.382139875252;5892.29292484896;6684.465242780566;6701.731930722814;6778.694958726771;6778.932210677929;6836.589804611739;5709.571782116358;5796.565257605696;5804.970975145097;5827.125931110282;5907;5848.678322692293;5858.238429004202;5861.41385861419;5862.14998825168;5865.94134058654;6531.379518945692;6583.63789991555;6584.341565843473;6588.604683718992;6602.900956485657;6740.3596658318365;6748.392644662004;6755.42578880781;6756.6959486822225;6854.177498700188;6385.29761726219;6479.546431749733;6518.315576864361;6586.37429444202;6591.242007169045;6585.440237579859;6585.670716464062;6600.60396376219;6601.075849380994;6603.9339606605245;6716.32836716344;6741.258461569321;6756.763513277012;6823.147106611674;6837.1111755471475;6583.473322134122;6600.339966003361;6613.140291762233;6618.6690665467495;6627.701753421011;6466.612003279818;6513.641749703812;6517.120188774455;6615.801525954229;6616.371444712745;6342.556021078481;6440.420362167428;6510.707018184098;6528.869422611616;6541.934580654323;6405.935940640534;6496.317886621837;6552.180977377828;6625.768098116736;6635.900461493178;6265.718042688181;6302.558820882494;6345.016522439029;6352.745890164341;6365.045243213555 18:15:37 INFO - PID 23561 | |1;ext.html;826.4834478450969;839.86562150056;856.353453142877;878.7583414560993;882.042983363051;39981.80009099954;40889;40910;40990.99999999996;40994;36794.26411471769;37032.81483592585;37085.258294834086;37087.25825483489;37112.628873711255;6906.7582634607925;7033.156021277454;7033.577985320897;7034.472414568902;7071.646417679121;6953.826154346131;7017.824554386156;7018.227994920555;7020.648967551628;7022.087128673265;7538.811529711774;7723.72966946157;7732.536047837148;7734.1492435832015;7737.613119344039;7641.350485208736;7710.151883292833;7710.922890771077;7712.845743085135;7712.884306735404;7456.217097204824;7568.5458872467825;7642.961785191094;7652.540847549165;7658.425618078666;37122.07194820151;37279;37577.24845503075;37589.81205093957;37598.4360234594;3431;3477.8087205203706;3480.1821571930577;3480.7215422766117;3481.094915322009;31388.21529461759;31536.842315788275;31565.84217078923;31623.20941976469;31625.20936976571;5088.211327244283;5092.71519869682;5114.2840002399325;5121.615878809067;5134.974325128388;192827;193435;193833;193898.9999999986;194185;44447.777761110985;44554.55445445569;44581;44595.777021114685;44667.55332446634;46805.531944680115;46878.296825547644;46884;46886;46906.29640555394;14107.506237281646;14230.28848557568;14261.928690356483;14282.285885705882;14291;11494.367809770543;11499.597514086967;11524.827127593093;11526.88473115275;11550.537978480934;13113.409896554678;13193.142445740996;13237.602871913858;13258.337083145803;13327.533536326182;5397.460253974571;5420.604468067118;5485.122380419114;5509.283793106871;5611.859703507445;992.8262554053011;1012.3976234140674;1022.0903395977585;1028.3469996552244;1028.4292217819182;22340.55318893613;22596.548069038858;22727.545449090925;22884.542309153723;23109.306720798402;1106.6458733205297;1111.349860331699;1111.5553778488509;1118.949647265875;1120.227043340109;11996.40017999114;12046.277223366626;12064.155509114278;12087.274763514217;12093.395330233629;221137;221766;222613;222735;223323;50781.492185078416;50919.745401272754;51063.7446812771;52600.47399526032;53683.46316536863;1393.7351903138372;1428.7642538980951;1433.240382597225;1433.3406632948752;1436.3895344478765;25924.22227333183;26197.73802262029;26324.473510530064;26347.239898186963;26599.468010640066;36423.27153456969;36526.63473365339;36552.634473655984;36579.817100914326;36599;206554;206821;207309;207658;207816;31666;31945.520817187295;31958.402079896376;32068;32123.03630891077;39964.60035399609;40080.1983960325;45255.54744452513;46595;46687.76656116698;32158.71365145368;32486.18784530311;32717.345653087283;32941.50587741138;33268.66731332656;32868.83565582157;33105.013699178126;33280.50079248765;33314.33371332608;33752.32495350128;37098.62901370952;37201.627983719816;37308.6269137316;37534.6246537542;37580.81209593934;32163.839180803945;32170.839145805057;32539.51190732188;32580;32974.17564560905;23427.414314642272;23612.055517779096;23666.526669466857;23942;24056.39859003539 18:15:37 INFO - PID 23561 | |2;jquery.html;555.8860433611108;557.6737608499028;564.37636411765;565.1014886330734;570.0907053250065;21307.68038479424;21759;22352.99411526481;22381.776182238173;22428.663570046443;24892.128775492816;25527.872360638215;25529;25596.488070238585;25652;6940.895886561706;7087.078679771623;7089.397401220903;7097.112860892388;7119.822004449904;6242.25092988842;6908.17101947767;6911.412529934962;6941.236463988957;7002.194747604014;6887.965560172192;6910.032595436643;6916.308369163068;6933.445324374038;6933.514653974224;6890.276520965302;6918.827029324257;6927.168739751211;6936.549124306929;6939.791806245821;6745.08941292929;6778.051072849805;6783.6269005204695;6797.762078327284;6812.557183783038;29952.25119372033;30427.543586846215;30558.08325750231;31974.20064498383;32085.1978700532;2108.7574928883223;2147.9033443494923;2157.3204440601316;2158.600658878097;2159.524904521003;19683.901580492147;20408.28571000008;20576.897115514326;20744.273950411814;20843.687344689843;2558.1558085831816;2579.3680548265793;2639.0895141176456;2640.4983053220017;2650.7879369650573;129307;132046.99999999904;132488.33755831255;132534.33732831274;132592;19193.232270709294;21315.1950003484;21344.35966920995;21491.67762483564;21720.34838954834;41222.58777412187;41351.1729765403;41452.37821432681;41496.37755433671;41526.37710434286;10573.735656608646;10672.146228301717;10741.462926853626;10778.4071876046;10865.728356791144;8750.081241469681;8831.293496520262;8839.513826739463;9101.271898248124;9105.317101217302;9224.907750922539;10788.622398216181;11121.27711698737;11282.153838461983;11544.538218471334;4324.524302326741;4356.259435895905;4406.383106365111;4417.271150260171;4439;965.3966271080575;981.8134554434635;982.111189373618;990.5195979949718;992.0922356044283;19088.71366929497;19436.4169074928;19774.505637358892;19819.30632427887;23481.882590586938;1008.3344992305043;1050.1598721023151;1069.7913906788258;1070.9357438553711;1071.5713714514256;11022.669319920415;11086.390248536409;11086.833697494543;11119.388433636066;11288.153388495895;481631;488325.88028257154;488781;492668;498720;116880;120297;120748.39625801815;120945.39527302307;121081.39459302647;1204.174471501198;1224.2103843021202;1244.2721008210117;1245.9501619935102;1250.93745312734;18165.636687266444;18283.26866925308;18293.725594116364;18357.54106147357;18527.166277517274;56872.86254274974;58297.12554311604;58986;59698.10452843124;59698.403015969285;69750;69935;70159.24601884994;70409;70814.29185708077;12036.819447708116;12149;13979.650508737363;14173.22047287409;14255;22046.66929996019;22171.334859954226;22222.222222222146;22419.327420177422;22502.5499490006;17520.912395437943;17596;17628.38300659522;17663.20515576828;17697.469075927744;15478.993865398714;15820.525384238492;16167.191640417697;16414.343426262814;16474.670506590042;18069.00620465887;18291.359802407384;18427.078646067912;18435.354762583243;18575.16411761447;14056.297185140498;14080.577582672126;14157.43370265219;14219.715605688036;14262.42950281977;17671.823281767018;18027.63944721072;18028.549286267422;18033.458996230132;18203.089845507937 18:15:37 INFO - PID 23561 | |3;mootools.html;1270.447355400401;1319.6041187643705;1321.187469706131;1324.1790090144111;1340.4102195034184;14408.135511869295;14705.632359190999;15016.47442339517;15019.249037548107;15023.924880375596;15113.546593602183;15358.692826143499;15404.152771597557;15409.69180616387;15430.459933902315;2688.9462210755773;2726.4138210284787;2727.5499542575453;2727.945441091177;2736.9726302736917;2637.920862374132;2649.6025596160634;2679.54447743884;2721.9047333343337;2727.986360068197;2711.1053352393665;2738.411241583059;2741.643586333774;2743.82165159264;2747.217043142705;2604.817662763607;2625.553655878505;2633.1310667479784;2638.419547699513;2674.0774432820645;2598.584226523747;2641;2647.1529110684587;2693.111273279813;2703.148508219924;14777.556673299818;14905.403783848633;14915.477958271409;14916.2541872907;14921.403143874231;7895.960520197362;8106.63520141595;8155.184481551857;8164.469309494863;8174.427790054699;5272.261883336336;5466.699331536764;5601.887962240773;5645.2096706461125;5695.857603559903;1833.651606194832;1913.5407502199512;1921.2123029557954;1969.428865628966;1971.753530808649;25047;25247.74752252472;25247.747522524907;25277.87361063183;25279.747202527924;6713.932860671331;6747.426468750113;6763.391294783493;6795.694193761293;6873.896891546631;16623.750643740354;16782.58043548921;16824.74762878558;16831.663366732595;16836.494905152864;7789.493682910593;7915.366770658334;7924.049114106228;7932.524048557105;7949.761507154794;7263.309985551364;7322.670479828314;7338.816529586803;7367.8894816577795;7376.262373762688;5111.05445492585;5285.36153792318;5312.62811603184;5318.760655770499;5474.616776825584;1397.839248486437;1433.1401159304542;1506.563096701966;1526.7862499250114;1548.42061097682;902.3638334973828;917.7797328641211;919.7102912582649;929.7907970706672;933.4679232837218;7942.841143177219;8224.177582241728;8242.052164001097;8268.214519620626;8376.288015518749;978.2858513285341;979.4955597867104;990.4697242759953;1028.6913925822223;1030.1655658916302;4983.277424773388;5098.566621837185;5291.1798671206025;5385.973070134624;5536.169574563848;19777.604447910962;19869;20476.69284960727;20554.28060017922;20593.897030514752;19791.802081979284;19807.900960495106;20188.09153588092;20189.394318170478;20358;11134.10927125828;11145.442727863574;11266;11296.209265351346;11371.886281137082;7867.881981770163;7883.369330453435;7903.170167132598;7929.405294602812;8004.51972881629;18032.63934721272;18256.634867302844;18304.084795760424;18316.72524912154;18628.720569191744;18387.632247355246;18429.72355414643;18441.446756597325;18943.810561894206;19051.90474047621;11909.702257443632;12433.564825231073;12586.559470418491;12588.496460141492;12593.68515787076;13387.196768193939;13403.597892063253;13641.24973126448;13650.112742671694;13652.112612680145;10936.453177340942;11009.174311926798;11127;11212.887871121184;11349.54601815918;10730.302530335503;10743.946280268861;10823.188260880308;11015.173861960546;11076.003159715665;9844;9964.302498825013;9964.701058968243;9975.850362244428;9982.151517121127;6883.414909732729;6890.483213758888;6999.615021173884;7296.525725827804;7328.267173282842;7055.506114571931;7057.36483716468;7059.329363710439;7126.429885609035;7150.249223831423 18:15:37 INFO - PID 23561 | |4;prototype.html;487.8303909775152;490.6567956930166;513.9845804625861;515.4845154845154;518.4167811212386;6177.16608257885;6181.350958149397;6182.783602573911;6228.564000519959;6320.652364119972;6003.459688628022;6078.817635470932;6099.939000610004;6107.908381374272;6165.290991535975;5208.687478751268;5229.790808367661;5244.711540865251;5268.288781014562;5277.6305658603915;5090.949090509103;5223.71269580173;5244.947550524503;5264.184051472028;5286.973565132169;5192.454792246816;5224.1119009768245;5243.9359496390225;5276.261323414725;5286.863324385256;5217.191335343009;5252.317198764155;5254.710990895499;5284.701154997589;5300.946990530084;4835.879103022417;4847.587955023792;4875.756212189376;4876.512348765131;4880.194767863334;6139.877202455926;6142.723577439026;6154.538409619252;6155.476784473325;6159.784407545759;5967.283925928917;5984.820455386345;6088.178095957033;6091.969540152271;6095.902737507247;6662.866742665168;6669.733210671568;6670.699818508178;6680.1983761948395;6688.86622267552;5239.5546378557865;5259.631825772198;5302.92045619316;5314.73426328682;5317.2821669074565;6971.3028697130385;6973.372396484341;7047.647617619098;7070.116235470567;7088.432925365958;5468.890622187534;5470.56235501159;5475.220553320187;5487.972560137174;5494.5988772862665;5559.833205003856;5561.527270181999;5590.329160500766;5601.551875849922;5605.80379686709;5996.500874781304;6050.878982420327;6065.878682426415;6077.96674565325;6094;6587.83530411734;6630.370114839083;6698.129243198353;6699.129113215348;6711.932880671228;1798.739182818484;1847.953801154955;1862.7205919112241;1912.4549503391468;1926.6917293233016;1421.0886357848676;1429.006840246019;1442.386985531145;1443.8556144385477;1454.5636309107226;5734.942650573441;5748.971255143698;5751.884962300731;5764.682942438206;5782.2483077199695;6630.767923122764;6686.297938716365;6729.764458243938;6773.221079575814;6779.389854912983;5780.306363236438;5816.214811000461;5831.912521312183;5835.795747148914;5844.736986835603;3507.9651502806732;3565.6969157621375;3571.9284214735476;3611.368010598135;3611.566612006576;6518.348165183538;6527.477801775846;6545.803625891135;6574.605523668595;6580.440662543738;6898.103021668981;6940.13248343957;6949.791506254821;6954.63542395588;6997.230304666585;6539.11721917535;6540.313267106981;6545.803625891231;6567.770128045496;6622.569532980245;6761.93238067613;6768.763093291711;6775.593464392152;6781.627010514272;6801.965990170018;6625.4699624029;6719.899201512079;6727.966360168168;6748.19021717397;6749.5612785168805;6494.837629059311;6517.3808488193545;6537.836554086186;6551.824058993342;6617.834554136185;4972.5027497249985;4974.527419895104;4987;5011.523905228997;5024.773885175249;6448.45188158993;6672.366125218096;6762.695678694372;6802.14973128359;6840.315968403319;6290.64751078502;6310.368963103653;6379.266384365857;6499.252585952487;6558.1802274715665;6524.249711283263;6526.258971231999;6538.300041989212;6545.116409284686;6550.7707230246715;6454.451371633464;6463.870722585616;6465.579737317059;6485.675716214265;6505.837354066186;6587.80236592903;6590.242122155822;6606.405423511907;6621.172353455818;6641.933580664325;6406.487481001415;6412.743490260337;6423.678816059271;6426.935730642634;6471.2234531856475 18:15:37 INFO - PID 23561 | |5;yui.html;799.7720649614861;817.4114637461026;820.8522465956128;858.8711693246013;894.8255090257402;17668.116594170304;18181.909090454545;18190.090495475208;18214.817851821495;18367.265309387607;19531.902340488312;19560;19594.21623135073;19599.60800783987;19739.407817765456;879.1077056787334;932.8041111366621;945.5036106044313;951.0727041134908;957.2437774158441;964.4888209249109;964.9565769540387;965.1506674126758;965.8020105878278;966.840471322231;949.705591266706;991.6628346362236;997.4115271989525;997.8952210017952;1009.7122320138762;982.4743762087285;982.7543114221445;983.066087217143;984.0700537991601;985.0395864032511;724.6775185042658;724.8369116948697;725.6952080126359;726.8291951391419;727.3272223193525;17808.3767068152;18015.72976405355;18029.909850450666;18089.276428942827;18091.095445227817;19756.209751609917;19941.601167976558;20166.79833201664;20259.89870050655;20304.69542956857;14795.334209960578;14953.850461495354;14957.326920288613;14969.251537423193;14979.700405991927;3646.5624125105155;3764.6800021998165;3783.8486460541544;3800.4869342638667;3803.904902377435;125122;125812;127839;129186;131337;16102;16654.83345166557;16694.83305166957;16712.331506739592;16722.08028558441;29067.12798616045;29291;29683.554746678816;29697.703022969494;29725.55411668827;7140.107486564179;7963.8805417918775;8085.716999904975;8105.1489593593005;8116.2695357418115;3612.3858943979585;3936.8622098226424;4177.958220417818;4216.578342165759;4219.198352313051;4965.478624744422;5112.667676601009;5127.2052831811125;5127.9230811537855;5130.486951304914;1068.5245065945735;1107.8116720157593;1121.5345631562973;1124.4771181400524;1128.9604863829727;689.0904006711194;691.7751730687546;700.5551474813531;710.3039021758602;715.9964200178965;11275;11885.40572971348;12953.287569183596;13300.600981970556;13342;683.4498228925663;691.5712258399724;692.9237783843773;694.0907411291224;702.4099756204813;5367.302250707383;5697.497821486369;5734.225879506297;5809.186713860063;5878.441548052928;117066;117798.4110079444;120070;120368.39815800865;121356.39321803511;91325;92800;94061.05938940523;95887.52056239675;99478;84090;85110.31154715522;85356;86274;87757;11451.02666273376;11706.765864682488;12089.758204835678;12151.027917766382;12374.257544547356;39311;39437.408438872866;39926.800365999145;40994.1801163981;41224.587754122076;69484;71798.64100679463;72391.27608723845;74818.25181748331;76011.61994189993;17074.2316595751;17668;17689.292428303237;17731.29074836992;17732.0247386395;20557.486062848548;20934.895325523885;20965.37103886886;21080.367588972356;21199.25802596902;16995.235214415134;17119.14404279756;17266.91366543159;17335.91332043382;17368.39210627622;19096.904515477334;19238.134283956977;19456.61086778285;19497;19510.31713890007;15316.387344506094;15349.386024558893;15384.461543845911;15393.538193854203;15519.301631426388;11243.212975091992;11415.200935934738;11520.193586449202;11526.07791376671;11545.48045337945;12377.443015064524;12874.227546347249;13502.932485337904;13676.042677012514;13791.07922831236 18:15:37 INFO - PID 23561 | __end_tp_report 18:15:37 INFO - PID 23561 | __start_cc_report 18:15:37 INFO - PID 23561 | _x_x_mozilla_cycle_collect,365 18:15:37 INFO - PID 23561 | __end_cc_report 18:15:37 INFO - PID 23561 | __startTimestamp1503450937679__endTimestamp 18:15:37 INFO - PID 23561 | 18:15:37 INFO - PID 23561 | ------- Summary: start ------- 18:15:37 INFO - PID 23561 | Number of tests: 6 18:15:37 INFO - PID 23561 | 18:15:37 INFO - PID 23561 | [#0] dojo.html Cycles:165 Average:6182.06 Median:6405.94 stddev:718.73 (11.2%) stddev-sans-first:684.03 18:15:37 INFO - PID 23561 | Values: 3283.8 3299.2 3314.5 3318.0 3329.4 6179.8 6223.5 6280.4 6296.6 6310.5 6125.3 6229.8 6241.4 6250.8 6270.9 5699.2 5703.2 5721.8 5740.3 5855.7 5744.3 5815.4 5816.4 5819.7 5837.5 5552.4 5762.9 5787.7 5844.9 5853.8 5661.0 5679.1 5714.1 5749.5 5798.2 5679.0 5700.2 5787.0 5814.1 5829.2 6189.6 6191.4 6231.9 6232.1 6249.2 6666.4 6682.5 6697.4 6771.8 6785.7 6729.1 6740.4 6747.0 6826.1 6826.3 6160.9 6211.6 6215.6 6231.1 6348.4 6840.1 6845.5 6875.2 6901.2 6939.4 6548.5 6548.9 6620.0 6633.2 6657.7 6689.5 6709.1 6749.5 6769.1 6796.6 6550.7 6555.3 6645.2 6647.2 6708.9 6623.4 6718.2 6728.4 6729.5 6736.0 5253.1 5290.0 5290.2 5296.5 5318.1 4586.8 4605.2 4614.4 4636.2 4641.2 5791.5 5873.8 5880.0 5884.4 5892.3 6684.5 6701.7 6778.7 6778.9 6836.6 5709.6 5796.6 5805.0 5827.1 5907.0 5848.7 5858.2 5861.4 5862.1 5865.9 6531.4 6583.6 6584.3 6588.6 6602.9 6740.4 6748.4 6755.4 6756.7 6854.2 6385.3 6479.5 6518.3 6586.4 6591.2 6585.4 6585.7 6600.6 6601.1 6603.9 6716.3 6741.3 6756.8 6823.1 6837.1 6583.5 6600.3 6613.1 6618.7 6627.7 6466.6 6513.6 6517.1 6615.8 6616.4 6342.6 6440.4 6510.7 6528.9 6541.9 6405.9 6496.3 6552.2 6625.8 6635.9 6265.7 6302.6 6345.0 6352.7 6365.0 18:15:37 INFO - PID 23561 | 18:15:37 INFO - PID 23561 | [#1] ext.html Cycles:180 Average:37235.55 Median:3479.00 stddev:53879.20 (1548.7%) stddev-sans-first:53960.99 18:15:37 INFO - PID 23561 | Values: 826.5 839.9 856.4 878.8 882.0 39981.8 40889.0 40910.0 40991.0 40994.0 36794.3 37032.8 37085.3 37087.3 37112.6 6906.8 7033.2 7033.6 7034.5 7071.6 6953.8 7017.8 7018.2 7020.6 7022.1 7538.8 7723.7 7732.5 7734.1 7737.6 7641.4 7710.2 7710.9 7712.8 7712.9 7456.2 7568.5 7643.0 7652.5 7658.4 37122.1 37279.0 37577.2 37589.8 37598.4 3431.0 3477.8 3480.2 3480.7 3481.1 31388.2 31536.8 31565.8 31623.2 31625.2 5088.2 5092.7 5114.3 5121.6 5135.0 192827.0 193435.0 193833.0 193899.0 194185.0 44447.8 44554.6 44581.0 44595.8 44667.6 46805.5 46878.3 46884.0 46886.0 46906.3 14107.5 14230.3 14261.9 14282.3 14291.0 11494.4 11499.6 11524.8 11526.9 11550.5 13113.4 13193.1 13237.6 13258.3 13327.5 5397.5 5420.6 5485.1 5509.3 5611.9 992.8 1012.4 1022.1 1028.3 1028.4 22340.6 22596.5 22727.5 22884.5 23109.3 1106.6 1111.3 1111.6 1118.9 1120.2 11996.4 12046.3 12064.2 12087.3 12093.4 221137.0 221766.0 222613.0 222735.0 223323.0 50781.5 50919.7 51063.7 52600.5 53683.5 1393.7 1428.8 1433.2 1433.3 1436.4 25924.2 26197.7 26324.5 26347.2 26599.5 36423.3 36526.6 36552.6 36579.8 36599.0 206554.0 206821.0 207309.0 207658.0 207816.0 31666.0 31945.5 31958.4 32068.0 32123.0 39964.6 40080.2 45255.5 46595.0 46687.8 32158.7 32486.2 32717.3 32941.5 33268.7 32868.8 33105.0 33280.5 33314.3 33752.3 37098.6 37201.6 37308.6 37534.6 37580.8 32163.8 32170.8 32539.5 32580.0 32974.2 23427.4 23612.1 23666.5 23942.0 24056.4 18:15:37 INFO - PID 23561 | 18:15:37 INFO - PID 23561 | [#2] jquery.html Cycles:180 Average:35543.50 Median:22109.00 stddev:82397.80 (372.7%) stddev-sans-first:82587.07 18:15:37 INFO - PID 23561 | Values: 555.9 557.7 564.4 565.1 570.1 21307.7 21759.0 22353.0 22381.8 22428.7 24892.1 25527.9 25529.0 25596.5 25652.0 6940.9 7087.1 7089.4 7097.1 7119.8 6242.3 6908.2 6911.4 6941.2 7002.2 6888.0 6910.0 6916.3 6933.4 6933.5 6890.3 6918.8 6927.2 6936.5 6939.8 6745.1 6778.1 6783.6 6797.8 6812.6 29952.3 30427.5 30558.1 31974.2 32085.2 2108.8 2147.9 2157.3 2158.6 2159.5 19683.9 20408.3 20576.9 20744.3 20843.7 2558.2 2579.4 2639.1 2640.5 2650.8 129307.0 132047.0 132488.3 132534.3 132592.0 19193.2 21315.2 21344.4 21491.7 21720.3 41222.6 41351.2 41452.4 41496.4 41526.4 10573.7 10672.1 10741.5 10778.4 10865.7 8750.1 8831.3 8839.5 9101.3 9105.3 9224.9 10788.6 11121.3 11282.2 11544.5 4324.5 4356.3 4406.4 4417.3 4439.0 965.4 981.8 982.1 990.5 992.1 19088.7 19436.4 19774.5 19819.3 23481.9 1008.3 1050.2 1069.8 1070.9 1071.6 11022.7 11086.4 11086.8 11119.4 11288.2 481631.0 488325.9 488781.0 492668.0 498720.0 116880.0 120297.0 120748.4 120945.4 121081.4 1204.2 1224.2 1244.3 1246.0 1250.9 18165.6 18283.3 18293.7 18357.5 18527.2 56872.9 58297.1 58986.0 59698.1 59698.4 69750.0 69935.0 70159.2 70409.0 70814.3 12036.8 12149.0 13979.7 14173.2 14255.0 22046.7 22171.3 22222.2 22419.3 22502.5 17520.9 17596.0 17628.4 17663.2 17697.5 15479.0 15820.5 16167.2 16414.3 16474.7 18069.0 18291.4 18427.1 18435.4 18575.2 14056.3 14080.6 14157.4 14219.7 14262.4 17671.8 18027.6 18028.5 18033.5 18203.1 18:15:37 INFO - PID 23561 | 18:15:37 INFO - PID 23561 | [#3] mootools.html Cycles:180 Average:9169.19 Median:2635.53 stddev:6386.63 (242.3%) stddev-sans-first:6376.97 18:15:37 INFO - PID 23561 | Values: 1270.4 1319.6 1321.2 1324.2 1340.4 14408.1 14705.6 15016.5 15019.2 15023.9 15113.5 15358.7 15404.2 15409.7 15430.5 2688.9 2726.4 2727.5 2727.9 2737.0 2637.9 2649.6 2679.5 2721.9 2728.0 2711.1 2738.4 2741.6 2743.8 2747.2 2604.8 2625.6 2633.1 2638.4 2674.1 2598.6 2641.0 2647.2 2693.1 2703.1 14777.6 14905.4 14915.5 14916.3 14921.4 7896.0 8106.6 8155.2 8164.5 8174.4 5272.3 5466.7 5601.9 5645.2 5695.9 1833.7 1913.5 1921.2 1969.4 1971.8 25047.0 25247.7 25247.7 25277.9 25279.7 6713.9 6747.4 6763.4 6795.7 6873.9 16623.8 16782.6 16824.7 16831.7 16836.5 7789.5 7915.4 7924.0 7932.5 7949.8 7263.3 7322.7 7338.8 7367.9 7376.3 5111.1 5285.4 5312.6 5318.8 5474.6 1397.8 1433.1 1506.6 1526.8 1548.4 902.4 917.8 919.7 929.8 933.5 7942.8 8224.2 8242.1 8268.2 8376.3 978.3 979.5 990.5 1028.7 1030.2 4983.3 5098.6 5291.2 5386.0 5536.2 19777.6 19869.0 20476.7 20554.3 20593.9 19791.8 19807.9 20188.1 20189.4 20358.0 11134.1 11145.4 11266.0 11296.2 11371.9 7867.9 7883.4 7903.2 7929.4 8004.5 18032.6 18256.6 18304.1 18316.7 18628.7 18387.6 18429.7 18441.4 18943.8 19051.9 11909.7 12433.6 12586.6 12588.5 12593.7 13387.2 13403.6 13641.2 13650.1 13652.1 10936.5 11009.2 11127.0 11212.9 11349.5 10730.3 10743.9 10823.2 11015.2 11076.0 9844.0 9964.3 9964.7 9975.9 9982.2 6883.4 6890.5 6999.6 7296.5 7328.3 7055.5 7057.4 7059.3 7126.4 7150.2 18:15:37 INFO - PID 23561 | 18:15:37 INFO - PID 23561 | [#4] prototype.html Cycles:180 Average:5640.52 Median:6148.63 stddev:1515.53 (24.6%) stddev-sans-first:1469.60 18:15:37 INFO - PID 23561 | Values: 487.8 490.7 514.0 515.5 518.4 6177.2 6181.4 6182.8 6228.6 6320.7 6003.5 6078.8 6099.9 6107.9 6165.3 5208.7 5229.8 5244.7 5268.3 5277.6 5090.9 5223.7 5244.9 5264.2 5287.0 5192.5 5224.1 5243.9 5276.3 5286.9 5217.2 5252.3 5254.7 5284.7 5300.9 4835.9 4847.6 4875.8 4876.5 4880.2 6139.9 6142.7 6154.5 6155.5 6159.8 5967.3 5984.8 6088.2 6092.0 6095.9 6662.9 6669.7 6670.7 6680.2 6688.9 5239.6 5259.6 5302.9 5314.7 5317.3 6971.3 6973.4 7047.6 7070.1 7088.4 5468.9 5470.6 5475.2 5488.0 5494.6 5559.8 5561.5 5590.3 5601.6 5605.8 5996.5 6050.9 6065.9 6078.0 6094.0 6587.8 6630.4 6698.1 6699.1 6711.9 1798.7 1848.0 1862.7 1912.5 1926.7 1421.1 1429.0 1442.4 1443.9 1454.6 5734.9 5749.0 5751.9 5764.7 5782.2 6630.8 6686.3 6729.8 6773.2 6779.4 5780.3 5816.2 5831.9 5835.8 5844.7 3508.0 3565.7 3571.9 3611.4 3611.6 6518.3 6527.5 6545.8 6574.6 6580.4 6898.1 6940.1 6949.8 6954.6 6997.2 6539.1 6540.3 6545.8 6567.8 6622.6 6761.9 6768.8 6775.6 6781.6 6802.0 6625.5 6719.9 6728.0 6748.2 6749.6 6494.8 6517.4 6537.8 6551.8 6617.8 4972.5 4974.5 4987.0 5011.5 5024.8 6448.5 6672.4 6762.7 6802.1 6840.3 6290.6 6310.4 6379.3 6499.3 6558.2 6524.2 6526.3 6538.3 6545.1 6550.8 6454.5 6463.9 6465.6 6485.7 6505.8 6587.8 6590.2 6606.4 6621.2 6641.9 6406.5 6412.7 6423.7 6426.9 6471.2 18:15:37 INFO - PID 23561 | 18:15:37 INFO - PID 23561 | [#5] yui.html Cycles:180 Average:23656.20 Median:25133.19 stddev:32981.42 (131.2%) stddev-sans-first:33029.29 18:15:37 INFO - PID 23561 | Values: 799.8 817.4 820.9 858.9 894.8 17668.1 18181.9 18190.1 18214.8 18367.3 19531.9 19560.0 19594.2 19599.6 19739.4 879.1 932.8 945.5 951.1 957.2 964.5 965.0 965.2 965.8 966.8 949.7 991.7 997.4 997.9 1009.7 982.5 982.8 983.1 984.1 985.0 724.7 724.8 725.7 726.8 727.3 17808.4 18015.7 18029.9 18089.3 18091.1 19756.2 19941.6 20166.8 20259.9 20304.7 14795.3 14953.9 14957.3 14969.3 14979.7 3646.6 3764.7 3783.8 3800.5 3803.9 125122.0 125812.0 127839.0 129186.0 131337.0 16102.0 16654.8 16694.8 16712.3 16722.1 29067.1 29291.0 29683.6 29697.7 29725.6 7140.1 7963.9 8085.7 8105.1 8116.3 3612.4 3936.9 4178.0 4216.6 4219.2 4965.5 5112.7 5127.2 5127.9 5130.5 1068.5 1107.8 1121.5 1124.5 1129.0 689.1 691.8 700.6 710.3 716.0 11275.0 11885.4 12953.3 13300.6 13342.0 683.4 691.6 692.9 694.1 702.4 5367.3 5697.5 5734.2 5809.2 5878.4 117066.0 117798.4 120070.0 120368.4 121356.4 91325.0 92800.0 94061.1 95887.5 99478.0 84090.0 85110.3 85356.0 86274.0 87757.0 11451.0 11706.8 12089.8 12151.0 12374.3 39311.0 39437.4 39926.8 40994.2 41224.6 69484.0 71798.6 72391.3 74818.3 76011.6 17074.2 17668.0 17689.3 17731.3 17732.0 20557.5 20934.9 20965.4 21080.4 21199.3 16995.2 17119.1 17266.9 17335.9 17368.4 19096.9 19238.1 19456.6 19497.0 19510.3 15316.4 15349.4 15384.5 15393.5 15519.3 11243.2 11415.2 11520.2 11526.1 11545.5 12377.4 12874.2 13502.9 13676.0 13791.1 18:15:37 INFO - PID 23561 | -------- Summary: end -------- 18:15:37 INFO - PID 23561 | 18:15:37 INFO - PID 23561 | [Parent 23561] WARNING: pipe error (60): Connection reset by peer: file /home/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 353 18:15:38 INFO - TEST-INFO | 23561: exit 0 18:15:38 INFO - TEST-OK | dromaeo_css | took 1111352ms 18:15:38 INFO - TEST-START | kraken 18:15:38 INFO - Initialising browser for kraken test... 18:15:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49820/getInfo.html -profile /tmp/tmpd1vBsy/profile 18:15:38 INFO - TEST-INFO | started process 23971 (/builds/slave/test/build/application/firefox/firefox http://localhost:49820/getInfo.html) 18:15:44 INFO - TEST-INFO | 23971: exit 0 18:15:44 INFO - Browser initialized. 18:15:44 INFO - Running cycle 1/1 for kraken test... 18:15:44 INFO - TEST-INFO | started process 24150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd1vBsy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:15:45 INFO - PID 24150 | 18:15:45 INFO - PID 24150 | (/builds/slave/test/build/application/firefox/firefox:24199): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:15:45 INFO - PID 24150 | 18:15:45 INFO - PID 24150 | 18:15:45 INFO - PID 24150 | (/builds/slave/test/build/application/firefox/firefox:24253): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:15:45 INFO - PID 24150 | 18:15:46 INFO - PID 24150 | __metrics Screen width/height:1600/1200 18:15:46 INFO - PID 24150 | colorDepth:24 18:15:46 INFO - PID 24150 | Browser inner width/height: 1024/768 18:15:46 INFO - PID 24150 | __metrics 18:15:55 INFO - PID 24150 | RSS: Main: 171642880 18:15:55 INFO - PID 24150 | 18:15:58 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49820/tests/kraken/driver.html?testName=audio-beat-detection) 18:15:59 INFO - PID 24150 | RSS: Main: 175443968 18:15:59 INFO - PID 24150 | 18:16:01 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49820/tests/kraken/driver.html?testName=audio-dft) 18:16:02 INFO - PID 24150 | RSS: Main: 178290688 18:16:02 INFO - PID 24150 | 18:16:05 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49820/tests/kraken/driver.html?testName=audio-fft) 18:16:06 INFO - PID 24150 | RSS: Main: 171876352 18:16:06 INFO - PID 24150 | 18:16:08 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49820/tests/kraken/driver.html?testName=audio-oscillator) 18:16:08 INFO - PID 24150 | RSS: Main: 172437504 18:16:08 INFO - PID 24150 | 18:16:11 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49820/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:16:11 INFO - PID 24150 | RSS: Main: 172765184 18:16:11 INFO - PID 24150 | 18:16:14 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49820/tests/kraken/driver.html?testName=imaging-darkroom) 18:16:15 INFO - PID 24150 | RSS: Main: 174088192 18:16:15 INFO - PID 24150 | 18:16:18 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49820/tests/kraken/driver.html?testName=imaging-desaturate) 18:16:19 INFO - PID 24150 | RSS: Main: 173858816 18:16:19 INFO - PID 24150 | 18:16:22 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49820/tests/kraken/driver.html?testName=json-parse-financial) 18:16:23 INFO - PID 24150 | RSS: Main: 174284800 18:16:23 INFO - PID 24150 | 18:16:24 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49820/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:16:25 INFO - PID 24150 | RSS: Main: 174333952 18:16:25 INFO - PID 24150 | 18:16:27 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49820/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:16:27 INFO - PID 24150 | RSS: Main: 173940736 18:16:27 INFO - PID 24150 | 18:16:29 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49820/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:16:30 INFO - PID 24150 | RSS: Main: 173903872 18:16:30 INFO - PID 24150 | 18:16:32 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:16:33 INFO - PID 24150 | RSS: Main: 174444544 18:16:33 INFO - PID 24150 | 18:16:36 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:16:37 INFO - PID 24150 | RSS: Main: 174575616 18:16:37 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | Cycle 1(1): loaded http://localhost:49820/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49820/tests/kraken/driver.html?testName=ai-astar) 18:16:39 INFO - PID 24150 | RSS: Main: 175841280 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | __start_tp_report 18:16:39 INFO - PID 24150 | _x_x_mozilla_page_load 18:16:39 INFO - PID 24150 | _x_x_mozilla_page_load_details 18:16:39 INFO - PID 24150 | |i|pagename|runs| 18:16:39 INFO - PID 24150 | |0;ai-astar;97;107;99;107;107;112;109;99;106;110 18:16:39 INFO - PID 24150 | |1;audio-beat-detection;140;116;148;170;121;146;148;118;166;123 18:16:39 INFO - PID 24150 | |2;audio-dft;163;164;166;163;164;163;161;163;164;168 18:16:39 INFO - PID 24150 | |3;audio-fft;74;73;73;166;74;74;74;73;167;75 18:16:39 INFO - PID 24150 | |4;audio-oscillator;80;79;150;79;78;79;132;80;78;135 18:16:39 INFO - PID 24150 | |5;imaging-gaussian-blur;114;114;113;113;114;114;114;116;114;115 18:16:39 INFO - PID 24150 | |6;imaging-darkroom;150;150;148;148;149;148;149;149;149;148 18:16:39 INFO - PID 24150 | |7;imaging-desaturate;94;94;94;94;94;93;95;94;94;95 18:16:39 INFO - PID 24150 | |8;json-parse-financial;56;52;56;51;52;52;53;57;51;51 18:16:39 INFO - PID 24150 | |9;json-stringify-tinderbox;56;55;56;55;55;56;55;60;57;56 18:16:39 INFO - PID 24150 | |10;stanford-crypto-aes;80;76;75;78;76;74;75;74;81;76 18:16:39 INFO - PID 24150 | |11;stanford-crypto-ccm;119;120;119;120;125;114;122;129;126;164 18:16:39 INFO - PID 24150 | |12;stanford-crypto-pbkdf2;171;169;180;171;172;168;167;169;166;169 18:16:39 INFO - PID 24150 | |13;stanford-crypto-sha256-iterative;65;66;66;64;64;63;64;65;66;74 18:16:39 INFO - PID 24150 | __end_tp_report 18:16:39 INFO - PID 24150 | __start_cc_report 18:16:39 INFO - PID 24150 | _x_x_mozilla_cycle_collect,940 18:16:39 INFO - PID 24150 | __end_cc_report 18:16:39 INFO - PID 24150 | __startTimestamp1503450999313__endTimestamp 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | ------- Summary: start ------- 18:16:39 INFO - PID 24150 | Number of tests: 14 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#0] ai-astar Cycles:10 Average:105.30 Median:111.00 stddev:5.14 (4.6%) stddev-sans-first:4.49 18:16:39 INFO - PID 24150 | Values: 97.0 107.0 99.0 107.0 107.0 112.0 109.0 99.0 106.0 110.0 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:147.00 stddev:19.57 (13.3%) stddev-sans-first:20.76 18:16:39 INFO - PID 24150 | Values: 140.0 116.0 148.0 170.0 121.0 146.0 148.0 118.0 166.0 123.0 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:1.91 (1.2%) stddev-sans-first:2.00 18:16:39 INFO - PID 24150 | Values: 163.0 164.0 166.0 163.0 164.0 163.0 161.0 163.0 164.0 168.0 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#3] audio-fft Cycles:10 Average:92.30 Median:74.00 stddev:39.11 (52.9%) stddev-sans-first:40.92 18:16:39 INFO - PID 24150 | Values: 74.0 73.0 73.0 166.0 74.0 74.0 74.0 73.0 167.0 75.0 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:79.00 stddev:29.34 (37.1%) stddev-sans-first:30.47 18:16:39 INFO - PID 24150 | Values: 80.0 79.0 150.0 79.0 78.0 79.0 132.0 80.0 78.0 135.0 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.88 (0.8%) stddev-sans-first:0.93 18:16:39 INFO - PID 24150 | Values: 114.0 114.0 113.0 113.0 114.0 114.0 114.0 116.0 114.0 115.0 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 18:16:39 INFO - PID 24150 | Values: 150.0 150.0 148.0 148.0 149.0 148.0 149.0 149.0 149.0 148.0 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 18:16:39 INFO - PID 24150 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 95.0 94.0 94.0 95.0 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:52.50 stddev:2.33 (4.4%) stddev-sans-first:2.22 18:16:39 INFO - PID 24150 | Values: 56.0 52.0 56.0 51.0 52.0 52.0 53.0 57.0 51.0 51.0 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:1.52 (2.7%) stddev-sans-first:1.62 18:16:39 INFO - PID 24150 | Values: 56.0 55.0 56.0 55.0 55.0 56.0 55.0 60.0 57.0 56.0 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.00 stddev:2.42 (3.2%) stddev-sans-first:2.20 18:16:39 INFO - PID 24150 | Values: 80.0 76.0 75.0 78.0 76.0 74.0 75.0 74.0 81.0 76.0 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:123.50 stddev:14.08 (11.4%) stddev-sans-first:14.71 18:16:39 INFO - PID 24150 | Values: 119.0 120.0 119.0 120.0 125.0 114.0 122.0 129.0 126.0 164.0 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:170.00 stddev:3.91 (2.3%) stddev-sans-first:4.14 18:16:39 INFO - PID 24150 | Values: 171.0 169.0 180.0 171.0 172.0 168.0 167.0 169.0 166.0 169.0 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.50 stddev:3.09 (4.7%) stddev-sans-first:3.27 18:16:39 INFO - PID 24150 | Values: 65.0 66.0 66.0 64.0 64.0 63.0 64.0 65.0 66.0 74.0 18:16:39 INFO - PID 24150 | -------- Summary: end -------- 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 18:16:39 INFO - PID 24150 | 18:16:39 INFO - PID 24150 | [Parent 24150] WARNING: pipe error (60): Connection reset by peer: file /home/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 353 18:16:39 INFO - PID 24150 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:16:40 INFO - TEST-INFO | 24150: exit 0 18:16:40 INFO - TEST-OK | kraken | took 61642ms 18:16:40 INFO - SUITE-END | took 1172s 18:16:40 INFO - Completed test suite (00:19:33) 18:16:40 INFO - javascript benchmark 18:16:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8578.097523879509, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.802971821691, 3299.208190034392, 3314.5028245763133, 3318.0377690469763, 3329.4007078725836, 6179.814605561829, 6223.471004964577, 6280.403361680639, 6296.6222026678315, 6310.526710496714, 6125.295591007036, 6229.813105606839, 6241.407066328703, 6250.781222657208, 6270.937290627093, 5699.202111704365, 5703.173039909221, 5721.828345149652, 5740.339860916007, 5855.707214639272, 5744.253247077874, 5815.38938411467, 5816.360200377955, 5819.738111784959, 5837.50381217597, 5552.361478429992, 5762.855928601776, 5787.652740835563, 5844.883102337972, 5853.824385268449, 5661.0, 5679.119736440858, 5714.114312281561, 5749.511291540224, 5798.1592669063175, 5679.034564124109, 5700.23046888673, 5786.971065144689, 5814.098814683731, 5829.183914252008, 6189.597676151081, 6191.380861913818, 6231.87536249277, 6232.096346029845, 6249.187605611287, 6666.366695163952, 6682.498812589075, 6697.397234248892, 6771.796846094625, 6785.660716964181, 6729.091572637681, 6740.39336459721, 6746.966265168643, 6826.146731658543, 6826.317368263183, 6160.87678246437, 6211.565190436671, 6215.595986260879, 6231.096491008823, 6348.428641422294, 6840.144981877265, 6845.486588505882, 6875.209350924608, 6901.206361268418, 6939.410150137194, 6548.508861835381, 6548.869022619521, 6620.0, 6633.204015518072, 6657.733690652417, 6689.531732778659, 6709.094272273278, 6749.460043196533, 6769.120014398097, 6796.592204467748, 6550.737970481223, 6555.278919318871, 6645.235797883209, 6647.169103862017, 6708.8993665094085, 6623.437007854386, 6718.193816742022, 6728.428083612947, 6729.461643068543, 6735.966320168368, 5253.054450199001, 5290.047791397586, 5290.1800220965815, 5296.470352964673, 5318.069337865858, 4586.839460618862, 4605.171069207575, 4614.446266448048, 4636.235021221461, 4641.210994130938, 5791.536677065825, 5873.794417195378, 5880.0, 5884.382139875252, 5892.29292484896, 6684.465242780566, 6701.731930722814, 6778.694958726771, 6778.932210677929, 6836.589804611739, 5709.571782116358, 5796.565257605696, 5804.970975145097, 5827.125931110282, 5907.0, 5848.678322692293, 5858.238429004202, 5861.41385861419, 5862.14998825168, 5865.94134058654, 6531.379518945692, 6583.63789991555, 6584.341565843473, 6588.604683718992, 6602.900956485657, 6740.3596658318365, 6748.392644662004, 6755.42578880781, 6756.6959486822225, 6854.177498700188, 6385.29761726219, 6479.546431749733, 6518.315576864361, 6586.37429444202, 6591.242007169045, 6585.440237579859, 6585.670716464062, 6600.60396376219, 6601.075849380994, 6603.9339606605245, 6716.32836716344, 6741.258461569321, 6756.763513277012, 6823.147106611674, 6837.1111755471475, 6583.473322134122, 6600.339966003361, 6613.140291762233, 6618.6690665467495, 6627.701753421011, 6466.612003279818, 6513.641749703812, 6517.120188774455, 6615.801525954229, 6616.371444712745, 6342.556021078481, 6440.420362167428, 6510.707018184098, 6528.869422611616, 6541.934580654323, 6405.935940640534, 6496.317886621837, 6552.180977377828, 6625.768098116736, 6635.900461493178, 6265.718042688181, 6302.558820882494, 6345.016522439029, 6352.745890164341, 6365.045243213555], "value": 6130.105223172877, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.4834478450969, 839.86562150056, 856.353453142877, 878.7583414560993, 882.042983363051, 39981.80009099954, 40889.0, 40910.0, 40990.99999999996, 40994.0, 36794.26411471769, 37032.81483592585, 37085.258294834086, 37087.25825483489, 37112.628873711255, 6906.7582634607925, 7033.156021277454, 7033.577985320897, 7034.472414568902, 7071.646417679121, 6953.826154346131, 7017.824554386156, 7018.227994920555, 7020.648967551628, 7022.087128673265, 7538.811529711774, 7723.72966946157, 7732.536047837148, 7734.1492435832015, 7737.613119344039, 7641.350485208736, 7710.151883292833, 7710.922890771077, 7712.845743085135, 7712.884306735404, 7456.217097204824, 7568.5458872467825, 7642.961785191094, 7652.540847549165, 7658.425618078666, 37122.07194820151, 37279.0, 37577.24845503075, 37589.81205093957, 37598.4360234594, 3431.0, 3477.8087205203706, 3480.1821571930577, 3480.7215422766117, 3481.094915322009, 31388.21529461759, 31536.842315788275, 31565.84217078923, 31623.20941976469, 31625.20936976571, 5088.211327244283, 5092.71519869682, 5114.2840002399325, 5121.615878809067, 5134.974325128388, 192827.0, 193435.0, 193833.0, 193898.9999999986, 194185.0, 44447.777761110985, 44554.55445445569, 44581.0, 44595.777021114685, 44667.55332446634, 46805.531944680115, 46878.296825547644, 46884.0, 46886.0, 46906.29640555394, 14107.506237281646, 14230.28848557568, 14261.928690356483, 14282.285885705882, 14291.0, 11494.367809770543, 11499.597514086967, 11524.827127593093, 11526.88473115275, 11550.537978480934, 13113.409896554678, 13193.142445740996, 13237.602871913858, 13258.337083145803, 13327.533536326182, 5397.460253974571, 5420.604468067118, 5485.122380419114, 5509.283793106871, 5611.859703507445, 992.8262554053011, 1012.3976234140674, 1022.0903395977585, 1028.3469996552244, 1028.4292217819182, 22340.55318893613, 22596.548069038858, 22727.545449090925, 22884.542309153723, 23109.306720798402, 1106.6458733205297, 1111.349860331699, 1111.5553778488509, 1118.949647265875, 1120.227043340109, 11996.40017999114, 12046.277223366626, 12064.155509114278, 12087.274763514217, 12093.395330233629, 221137.0, 221766.0, 222613.0, 222735.0, 223323.0, 50781.492185078416, 50919.745401272754, 51063.7446812771, 52600.47399526032, 53683.46316536863, 1393.7351903138372, 1428.7642538980951, 1433.240382597225, 1433.3406632948752, 1436.3895344478765, 25924.22227333183, 26197.73802262029, 26324.473510530064, 26347.239898186963, 26599.468010640066, 36423.27153456969, 36526.63473365339, 36552.634473655984, 36579.817100914326, 36599.0, 206554.0, 206821.0, 207309.0, 207658.0, 207816.0, 31666.0, 31945.520817187295, 31958.402079896376, 32068.0, 32123.03630891077, 39964.60035399609, 40080.1983960325, 45255.54744452513, 46595.0, 46687.76656116698, 32158.71365145368, 32486.18784530311, 32717.345653087283, 32941.50587741138, 33268.66731332656, 32868.83565582157, 33105.013699178126, 33280.50079248765, 33314.33371332608, 33752.32495350128, 37098.62901370952, 37201.627983719816, 37308.6269137316, 37534.6246537542, 37580.81209593934, 32163.839180803945, 32170.839145805057, 32539.51190732188, 32580.0, 32974.17564560905, 23427.414314642272, 23612.055517779096, 23666.526669466857, 23942.0, 24056.39859003539], "value": 16796.9160721313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.8860433611108, 557.6737608499028, 564.37636411765, 565.1014886330734, 570.0907053250065, 21307.68038479424, 21759.0, 22352.99411526481, 22381.776182238173, 22428.663570046443, 24892.128775492816, 25527.872360638215, 25529.0, 25596.488070238585, 25652.0, 6940.895886561706, 7087.078679771623, 7089.397401220903, 7097.112860892388, 7119.822004449904, 6242.25092988842, 6908.17101947767, 6911.412529934962, 6941.236463988957, 7002.194747604014, 6887.965560172192, 6910.032595436643, 6916.308369163068, 6933.445324374038, 6933.514653974224, 6890.276520965302, 6918.827029324257, 6927.168739751211, 6936.549124306929, 6939.791806245821, 6745.08941292929, 6778.051072849805, 6783.6269005204695, 6797.762078327284, 6812.557183783038, 29952.25119372033, 30427.543586846215, 30558.08325750231, 31974.20064498383, 32085.1978700532, 2108.7574928883223, 2147.9033443494923, 2157.3204440601316, 2158.600658878097, 2159.524904521003, 19683.901580492147, 20408.28571000008, 20576.897115514326, 20744.273950411814, 20843.687344689843, 2558.1558085831816, 2579.3680548265793, 2639.0895141176456, 2640.4983053220017, 2650.7879369650573, 129307.0, 132046.99999999904, 132488.33755831255, 132534.33732831274, 132592.0, 19193.232270709294, 21315.1950003484, 21344.35966920995, 21491.67762483564, 21720.34838954834, 41222.58777412187, 41351.1729765403, 41452.37821432681, 41496.37755433671, 41526.37710434286, 10573.735656608646, 10672.146228301717, 10741.462926853626, 10778.4071876046, 10865.728356791144, 8750.081241469681, 8831.293496520262, 8839.513826739463, 9101.271898248124, 9105.317101217302, 9224.907750922539, 10788.622398216181, 11121.27711698737, 11282.153838461983, 11544.538218471334, 4324.524302326741, 4356.259435895905, 4406.383106365111, 4417.271150260171, 4439.0, 965.3966271080575, 981.8134554434635, 982.111189373618, 990.5195979949718, 992.0922356044283, 19088.71366929497, 19436.4169074928, 19774.505637358892, 19819.30632427887, 23481.882590586938, 1008.3344992305043, 1050.1598721023151, 1069.7913906788258, 1070.9357438553711, 1071.5713714514256, 11022.669319920415, 11086.390248536409, 11086.833697494543, 11119.388433636066, 11288.153388495895, 481631.0, 488325.88028257154, 488781.0, 492668.0, 498720.0, 116880.0, 120297.0, 120748.39625801815, 120945.39527302307, 121081.39459302647, 1204.174471501198, 1224.2103843021202, 1244.2721008210117, 1245.9501619935102, 1250.93745312734, 18165.636687266444, 18283.26866925308, 18293.725594116364, 18357.54106147357, 18527.166277517274, 56872.86254274974, 58297.12554311604, 58986.0, 59698.10452843124, 59698.403015969285, 69750.0, 69935.0, 70159.24601884994, 70409.0, 70814.29185708077, 12036.819447708116, 12149.0, 13979.650508737363, 14173.22047287409, 14255.0, 22046.66929996019, 22171.334859954226, 22222.222222222146, 22419.327420177422, 22502.5499490006, 17520.912395437943, 17596.0, 17628.38300659522, 17663.20515576828, 17697.469075927744, 15478.993865398714, 15820.525384238492, 16167.191640417697, 16414.343426262814, 16474.670506590042, 18069.00620465887, 18291.359802407384, 18427.078646067912, 18435.354762583243, 18575.16411761447, 14056.297185140498, 14080.577582672126, 14157.43370265219, 14219.715605688036, 14262.42950281977, 17671.823281767018, 18027.63944721072, 18028.549286267422, 18033.458996230132, 18203.089845507937], "value": 12640.743215740536, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1270.447355400401, 1319.6041187643705, 1321.187469706131, 1324.1790090144111, 1340.4102195034184, 14408.135511869295, 14705.632359190999, 15016.47442339517, 15019.249037548107, 15023.924880375596, 15113.546593602183, 15358.692826143499, 15404.152771597557, 15409.69180616387, 15430.459933902315, 2688.9462210755773, 2726.4138210284787, 2727.5499542575453, 2727.945441091177, 2736.9726302736917, 2637.920862374132, 2649.6025596160634, 2679.54447743884, 2721.9047333343337, 2727.986360068197, 2711.1053352393665, 2738.411241583059, 2741.643586333774, 2743.82165159264, 2747.217043142705, 2604.817662763607, 2625.553655878505, 2633.1310667479784, 2638.419547699513, 2674.0774432820645, 2598.584226523747, 2641.0, 2647.1529110684587, 2693.111273279813, 2703.148508219924, 14777.556673299818, 14905.403783848633, 14915.477958271409, 14916.2541872907, 14921.403143874231, 7895.960520197362, 8106.63520141595, 8155.184481551857, 8164.469309494863, 8174.427790054699, 5272.261883336336, 5466.699331536764, 5601.887962240773, 5645.2096706461125, 5695.857603559903, 1833.651606194832, 1913.5407502199512, 1921.2123029557954, 1969.428865628966, 1971.753530808649, 25047.0, 25247.74752252472, 25247.747522524907, 25277.87361063183, 25279.747202527924, 6713.932860671331, 6747.426468750113, 6763.391294783493, 6795.694193761293, 6873.896891546631, 16623.750643740354, 16782.58043548921, 16824.74762878558, 16831.663366732595, 16836.494905152864, 7789.493682910593, 7915.366770658334, 7924.049114106228, 7932.524048557105, 7949.761507154794, 7263.309985551364, 7322.670479828314, 7338.816529586803, 7367.8894816577795, 7376.262373762688, 5111.05445492585, 5285.36153792318, 5312.62811603184, 5318.760655770499, 5474.616776825584, 1397.839248486437, 1433.1401159304542, 1506.563096701966, 1526.7862499250114, 1548.42061097682, 902.3638334973828, 917.7797328641211, 919.7102912582649, 929.7907970706672, 933.4679232837218, 7942.841143177219, 8224.177582241728, 8242.052164001097, 8268.214519620626, 8376.288015518749, 978.2858513285341, 979.4955597867104, 990.4697242759953, 1028.6913925822223, 1030.1655658916302, 4983.277424773388, 5098.566621837185, 5291.1798671206025, 5385.973070134624, 5536.169574563848, 19777.604447910962, 19869.0, 20476.69284960727, 20554.28060017922, 20593.897030514752, 19791.802081979284, 19807.900960495106, 20188.09153588092, 20189.394318170478, 20358.0, 11134.10927125828, 11145.442727863574, 11266.0, 11296.209265351346, 11371.886281137082, 7867.881981770163, 7883.369330453435, 7903.170167132598, 7929.405294602812, 8004.51972881629, 18032.63934721272, 18256.634867302844, 18304.084795760424, 18316.72524912154, 18628.720569191744, 18387.632247355246, 18429.72355414643, 18441.446756597325, 18943.810561894206, 19051.90474047621, 11909.702257443632, 12433.564825231073, 12586.559470418491, 12588.496460141492, 12593.68515787076, 13387.196768193939, 13403.597892063253, 13641.24973126448, 13650.112742671694, 13652.112612680145, 10936.453177340942, 11009.174311926798, 11127.0, 11212.887871121184, 11349.54601815918, 10730.302530335503, 10743.946280268861, 10823.188260880308, 11015.173861960546, 11076.003159715665, 9844.0, 9964.302498825013, 9964.701058968243, 9975.850362244428, 9982.151517121127, 6883.414909732729, 6890.483213758888, 6999.615021173884, 7296.525725827804, 7328.267173282842, 7055.506114571931, 7057.36483716468, 7059.329363710439, 7126.429885609035, 7150.249223831423], "value": 6618.239912617287, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.8303909775152, 490.6567956930166, 513.9845804625861, 515.4845154845154, 518.4167811212386, 6177.16608257885, 6181.350958149397, 6182.783602573911, 6228.564000519959, 6320.652364119972, 6003.459688628022, 6078.817635470932, 6099.939000610004, 6107.908381374272, 6165.290991535975, 5208.687478751268, 5229.790808367661, 5244.711540865251, 5268.288781014562, 5277.6305658603915, 5090.949090509103, 5223.71269580173, 5244.947550524503, 5264.184051472028, 5286.973565132169, 5192.454792246816, 5224.1119009768245, 5243.9359496390225, 5276.261323414725, 5286.863324385256, 5217.191335343009, 5252.317198764155, 5254.710990895499, 5284.701154997589, 5300.946990530084, 4835.879103022417, 4847.587955023792, 4875.756212189376, 4876.512348765131, 4880.194767863334, 6139.877202455926, 6142.723577439026, 6154.538409619252, 6155.476784473325, 6159.784407545759, 5967.283925928917, 5984.820455386345, 6088.178095957033, 6091.969540152271, 6095.902737507247, 6662.866742665168, 6669.733210671568, 6670.699818508178, 6680.1983761948395, 6688.86622267552, 5239.5546378557865, 5259.631825772198, 5302.92045619316, 5314.73426328682, 5317.2821669074565, 6971.3028697130385, 6973.372396484341, 7047.647617619098, 7070.116235470567, 7088.432925365958, 5468.890622187534, 5470.56235501159, 5475.220553320187, 5487.972560137174, 5494.5988772862665, 5559.833205003856, 5561.527270181999, 5590.329160500766, 5601.551875849922, 5605.80379686709, 5996.500874781304, 6050.878982420327, 6065.878682426415, 6077.96674565325, 6094.0, 6587.83530411734, 6630.370114839083, 6698.129243198353, 6699.129113215348, 6711.932880671228, 1798.739182818484, 1847.953801154955, 1862.7205919112241, 1912.4549503391468, 1926.6917293233016, 1421.0886357848676, 1429.006840246019, 1442.386985531145, 1443.8556144385477, 1454.5636309107226, 5734.942650573441, 5748.971255143698, 5751.884962300731, 5764.682942438206, 5782.2483077199695, 6630.767923122764, 6686.297938716365, 6729.764458243938, 6773.221079575814, 6779.389854912983, 5780.306363236438, 5816.214811000461, 5831.912521312183, 5835.795747148914, 5844.736986835603, 3507.9651502806732, 3565.6969157621375, 3571.9284214735476, 3611.368010598135, 3611.566612006576, 6518.348165183538, 6527.477801775846, 6545.803625891135, 6574.605523668595, 6580.440662543738, 6898.103021668981, 6940.13248343957, 6949.791506254821, 6954.63542395588, 6997.230304666585, 6539.11721917535, 6540.313267106981, 6545.803625891231, 6567.770128045496, 6622.569532980245, 6761.93238067613, 6768.763093291711, 6775.593464392152, 6781.627010514272, 6801.965990170018, 6625.4699624029, 6719.899201512079, 6727.966360168168, 6748.19021717397, 6749.5612785168805, 6494.837629059311, 6517.3808488193545, 6537.836554086186, 6551.824058993342, 6617.834554136185, 4972.5027497249985, 4974.527419895104, 4987.0, 5011.523905228997, 5024.773885175249, 6448.45188158993, 6672.366125218096, 6762.695678694372, 6802.14973128359, 6840.315968403319, 6290.64751078502, 6310.368963103653, 6379.266384365857, 6499.252585952487, 6558.1802274715665, 6524.249711283263, 6526.258971231999, 6538.300041989212, 6545.116409284686, 6550.7707230246715, 6454.451371633464, 6463.870722585616, 6465.579737317059, 6485.675716214265, 6505.837354066186, 6587.80236592903, 6590.242122155822, 6606.405423511907, 6621.172353455818, 6641.933580664325, 6406.487481001415, 6412.743490260337, 6423.678816059271, 6426.935730642634, 6471.2234531856475], "value": 5199.8450015310655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.7720649614861, 817.4114637461026, 820.8522465956128, 858.8711693246013, 894.8255090257402, 17668.116594170304, 18181.909090454545, 18190.090495475208, 18214.817851821495, 18367.265309387607, 19531.902340488312, 19560.0, 19594.21623135073, 19599.60800783987, 19739.407817765456, 879.1077056787334, 932.8041111366621, 945.5036106044313, 951.0727041134908, 957.2437774158441, 964.4888209249109, 964.9565769540387, 965.1506674126758, 965.8020105878278, 966.840471322231, 949.705591266706, 991.6628346362236, 997.4115271989525, 997.8952210017952, 1009.7122320138762, 982.4743762087285, 982.7543114221445, 983.066087217143, 984.0700537991601, 985.0395864032511, 724.6775185042658, 724.8369116948697, 725.6952080126359, 726.8291951391419, 727.3272223193525, 17808.3767068152, 18015.72976405355, 18029.909850450666, 18089.276428942827, 18091.095445227817, 19756.209751609917, 19941.601167976558, 20166.79833201664, 20259.89870050655, 20304.69542956857, 14795.334209960578, 14953.850461495354, 14957.326920288613, 14969.251537423193, 14979.700405991927, 3646.5624125105155, 3764.6800021998165, 3783.8486460541544, 3800.4869342638667, 3803.904902377435, 125122.0, 125812.0, 127839.0, 129186.0, 131337.0, 16102.0, 16654.83345166557, 16694.83305166957, 16712.331506739592, 16722.08028558441, 29067.12798616045, 29291.0, 29683.554746678816, 29697.703022969494, 29725.55411668827, 7140.107486564179, 7963.8805417918775, 8085.716999904975, 8105.1489593593005, 8116.2695357418115, 3612.3858943979585, 3936.8622098226424, 4177.958220417818, 4216.578342165759, 4219.198352313051, 4965.478624744422, 5112.667676601009, 5127.2052831811125, 5127.9230811537855, 5130.486951304914, 1068.5245065945735, 1107.8116720157593, 1121.5345631562973, 1124.4771181400524, 1128.9604863829727, 689.0904006711194, 691.7751730687546, 700.5551474813531, 710.3039021758602, 715.9964200178965, 11275.0, 11885.40572971348, 12953.287569183596, 13300.600981970556, 13342.0, 683.4498228925663, 691.5712258399724, 692.9237783843773, 694.0907411291224, 702.4099756204813, 5367.302250707383, 5697.497821486369, 5734.225879506297, 5809.186713860063, 5878.441548052928, 117066.0, 117798.4110079444, 120070.0, 120368.39815800865, 121356.39321803511, 91325.0, 92800.0, 94061.05938940523, 95887.52056239675, 99478.0, 84090.0, 85110.31154715522, 85356.0, 86274.0, 87757.0, 11451.02666273376, 11706.765864682488, 12089.758204835678, 12151.027917766382, 12374.257544547356, 39311.0, 39437.408438872866, 39926.800365999145, 40994.1801163981, 41224.587754122076, 69484.0, 71798.64100679463, 72391.27608723845, 74818.25181748331, 76011.61994189993, 17074.2316595751, 17668.0, 17689.292428303237, 17731.29074836992, 17732.0247386395, 20557.486062848548, 20934.895325523885, 20965.37103886886, 21080.367588972356, 21199.25802596902, 16995.235214415134, 17119.14404279756, 17266.91366543159, 17335.91332043382, 17368.39210627622, 19096.904515477334, 19238.134283956977, 19456.61086778285, 19497.0, 19510.31713890007, 15316.387344506094, 15349.386024558893, 15384.461543845911, 15393.538193854203, 15519.301631426388, 11243.212975091992, 11415.200935934738, 11520.193586449202, 11526.07791376671, 11545.48045337945, 12377.443015064524, 12874.227546347249, 13502.932485337904, 13676.042677012514, 13791.07922831236], "value": 8894.4199156663, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 99.0, 107.0, 107.0, 112.0, 109.0, 99.0, 106.0, 110.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 116.0, 148.0, 170.0, 121.0, 146.0, 148.0, 118.0, 166.0, 123.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 166.0, 163.0, 164.0, 163.0, 161.0, 163.0, 164.0, 168.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 73.0, 166.0, 74.0, 74.0, 74.0, 73.0, 167.0, 75.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 150.0, 79.0, 78.0, 79.0, 132.0, 80.0, 78.0, 135.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 116.0, 114.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 148.0, 148.0, 149.0, 148.0, 149.0, 149.0, 149.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 95.0, 94.0, 94.0, 95.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 56.0, 51.0, 52.0, 52.0, 53.0, 57.0, 51.0, 51.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 55.0, 55.0, 56.0, 55.0, 60.0, 57.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 75.0, 78.0, 76.0, 74.0, 75.0, 74.0, 81.0, 76.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 120.0, 119.0, 120.0, 125.0, 114.0, 122.0, 129.0, 126.0, 164.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 180.0, 171.0, 172.0, 168.0, 167.0, 169.0, 166.0, 169.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 64.0, 64.0, 63.0, 64.0, 65.0, 66.0, 74.0], "value": 65.7, "unit": "score"}]}]} 18:16:40 INFO - Return code: 0 18:16:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:16:40 INFO - # TBPL SUCCESS # 18:16:40 INFO - Running post-action listener: _package_coverage_data 18:16:40 INFO - Running post-action listener: _resource_record_post_action 18:16:40 INFO - [mozharness: 2017-08-23 01:16:40.594193Z] Finished run-tests step (success) 18:16:40 INFO - Running post-run listener: _resource_record_post_run 18:16:40 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 446808064; Read time: 8; Write time: 301048 18:16:40 INFO - TinderboxPrint: CPU usage
13.1% 18:16:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:16:40 INFO - TinderboxPrint: I/O write bytes / time
446,808,064 / 301,048 18:16:40 INFO - TinderboxPrint: CPU idle
8,249.5 (86.9%) 18:16:40 INFO - TinderboxPrint: CPU user
1,195.3 (12.6%) 18:16:40 INFO - TinderboxPrint: Swap in / out
0 / 0 18:16:40 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106246144; Read time: 0; Write time: 120716 18:16:40 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:16:40 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 339439616; Read time: 0; Write time: 180300 18:16:41 INFO - Running post-run listener: _upload_blobber_files 18:16:41 INFO - Blob upload gear active. 18:16:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:16:41 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 18:16:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:16:41 INFO - (blobuploader) - INFO - Open directory for files ... 18:16:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:16:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:16:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:42 INFO - (blobuploader) - INFO - Done attempting. 18:16:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:16:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:16:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:43 INFO - (blobuploader) - INFO - Done attempting. 18:16:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:16:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:16:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:50 INFO - (blobuploader) - INFO - Done attempting. 18:16:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:16:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:16:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:16:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:16:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:16:51 INFO - (blobuploader) - INFO - Done attempting. 18:16:51 INFO - (blobuploader) - INFO - Iteration through files over. 18:16:51 INFO - Return code: 0 18:16:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:16:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:16:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fe67f7ec59d62b1d60450181c16a38b37bcc3a28385c98c149031cb0c3b9ad3dc61cd6665174098c1ea66a6853827441f0db94ab77857238ec18d713bec35cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0432c9d7a54ee5adf828555beedb14b3cd7383c291176178b0dbce45b21ce5c20f3bb5fb083dacd292ae60318e468373fcd8a8152fd68f9a310a56bf139faaa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9519b984907c1c1733f9c574047ccfa88e1b2c19f24b7cfcb8df820dcb0679514c0c91325979897cfde126a8c9e5330001f2f52ed6464ac8dd9961496cbd356", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4306054311f461fa2f7791c7dae159a74606146dd2fb16dd29c7ab5714c0ccdd4a5b691db1cea1384aed232b41750d1c3ed8b8397e478ce9fc689c58728995e0"} 18:16:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:16:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:16:51 INFO - Contents: 18:16:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fe67f7ec59d62b1d60450181c16a38b37bcc3a28385c98c149031cb0c3b9ad3dc61cd6665174098c1ea66a6853827441f0db94ab77857238ec18d713bec35cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0432c9d7a54ee5adf828555beedb14b3cd7383c291176178b0dbce45b21ce5c20f3bb5fb083dacd292ae60318e468373fcd8a8152fd68f9a310a56bf139faaa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9519b984907c1c1733f9c574047ccfa88e1b2c19f24b7cfcb8df820dcb0679514c0c91325979897cfde126a8c9e5330001f2f52ed6464ac8dd9961496cbd356", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4306054311f461fa2f7791c7dae159a74606146dd2fb16dd29c7ab5714c0ccdd4a5b691db1cea1384aed232b41750d1c3ed8b8397e478ce9fc689c58728995e0"} 18:16:51 INFO - Running post-run listener: copy_logs_to_upload_dir 18:16:51 INFO - Copying logs to upload dir... 18:16:51 INFO - mkdir: /builds/slave/test/build/upload/logs 18:16:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.856972 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-22 18:16:50.959854) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 18:16:50.963829) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fe67f7ec59d62b1d60450181c16a38b37bcc3a28385c98c149031cb0c3b9ad3dc61cd6665174098c1ea66a6853827441f0db94ab77857238ec18d713bec35cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0432c9d7a54ee5adf828555beedb14b3cd7383c291176178b0dbce45b21ce5c20f3bb5fb083dacd292ae60318e468373fcd8a8152fd68f9a310a56bf139faaa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9519b984907c1c1733f9c574047ccfa88e1b2c19f24b7cfcb8df820dcb0679514c0c91325979897cfde126a8c9e5330001f2f52ed6464ac8dd9961496cbd356", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4306054311f461fa2f7791c7dae159a74606146dd2fb16dd29c7ab5714c0ccdd4a5b691db1cea1384aed232b41750d1c3ed8b8397e478ce9fc689c58728995e0"} build_url:https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/IbzxS1zGRz6yU7eidXiiKg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4fe67f7ec59d62b1d60450181c16a38b37bcc3a28385c98c149031cb0c3b9ad3dc61cd6665174098c1ea66a6853827441f0db94ab77857238ec18d713bec35cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0432c9d7a54ee5adf828555beedb14b3cd7383c291176178b0dbce45b21ce5c20f3bb5fb083dacd292ae60318e468373fcd8a8152fd68f9a310a56bf139faaa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9519b984907c1c1733f9c574047ccfa88e1b2c19f24b7cfcb8df820dcb0679514c0c91325979897cfde126a8c9e5330001f2f52ed6464ac8dd9961496cbd356", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4306054311f461fa2f7791c7dae159a74606146dd2fb16dd29c7ab5714c0ccdd4a5b691db1cea1384aed232b41750d1c3ed8b8397e478ce9fc689c58728995e0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 18:16:50.993631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 18:16:50.994011) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1503449756.581928-1252284724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 18:16:51.076532) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 18:16:51.076854) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 18:16:51.077157) ========= ========= Total master_lag: 0.17 =========