builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-074 starttime: 1503579396.61 results: success (0) revision: 892c8916ba32b7733e06bfbfdd4083ffae3ca028 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 05:56:36.608789) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-24 05:56:36.609263) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 05:56:36.609542) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-24 05:56:36.625275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:56:36.625591) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-24 05:56:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 86.9M=0s 2017-08-24 05:56:36 (86.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112258 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:56:36.752814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:56:36.756148) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024293 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 05:56:36.805955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-24 05:56:36.809400) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 892c8916ba32b7733e06bfbfdd4083ffae3ca028 --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 892c8916ba32b7733e06bfbfdd4083ffae3ca028 --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=23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-24 05:56:36,862 truncating revision to first 12 chars 2017-08-24 05:56:36,863 Setting DEBUG logging. 2017-08-24 05:56:36,863 attempt 1/10 2017-08-24 05:56:36,863 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/892c8916ba32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-24 05:56:38,271 unpacking tar archive at: mozilla-central-892c8916ba32/testing/mozharness/ program finished with exit code 0 elapsedTime=1.762977 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-24 05:56:38.586835) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 05:56:38.590218) ========= script_repo_revision: 892c8916ba32b7733e06bfbfdd4083ffae3ca028 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-24 05:56:38.590626) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 05:56:38.590882) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-24 05:56:38.602268) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-24 05:56:38.602567) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:56:38 INFO - MultiFileLogger online at 20170824 05:56:38 in /builds/slave/test 05:56:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:56:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:56:38 INFO - {'append_to_log': False, 05:56:38 INFO - 'base_work_dir': '/builds/slave/test', 05:56:38 INFO - 'blob_upload_branch': 'Firefox', 05:56:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:56:38 INFO - 'branch': 'Firefox', 05:56:38 INFO - 'buildbot_json_path': 'buildprops.json', 05:56:38 INFO - 'code_coverage': False, 05:56:38 INFO - 'config_files': ('talos/linux_config.py',), 05:56:38 INFO - 'default_actions': ('clobber', 05:56:38 INFO - 'read-buildbot-config', 05:56:38 INFO - 'download-and-extract', 05:56:38 INFO - 'populate-webroot', 05:56:38 INFO - 'create-virtualenv', 05:56:38 INFO - 'install', 05:56:38 INFO - 'setup-mitmproxy', 05:56:38 INFO - 'run-tests'), 05:56:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:56:38 INFO - 'disable_ccov_upload': False, 05:56:38 INFO - 'download_minidump_stackwalk': True, 05:56:38 INFO - 'download_symbols': 'ondemand', 05:56:38 INFO - 'enable_stylo': False, 05:56:38 INFO - 'enable_webrender': False, 05:56:38 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 05:56:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:56:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:56:38 INFO - 'gecko_profile': False, 05:56:38 INFO - 'gecko_profile_interval': 0, 05:56:38 INFO - 'installer_path': 'installer.exe', 05:56:38 INFO - 'log_level': 'info', 05:56:38 INFO - 'log_name': 'talos', 05:56:38 INFO - 'log_to_console': True, 05:56:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:56:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:56:38 INFO - 'opt_config_files': (), 05:56:38 INFO - 'pip_index': False, 05:56:38 INFO - 'suite': 'dromaeojs-e10s', 05:56:38 INFO - 'system_bits': '32', 05:56:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:56:38 INFO - 'title': 'talos-linux64-ix-074', 05:56:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:56:38 INFO - 'use_talos_json': True, 05:56:38 INFO - 'verify': 'False', 05:56:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:56:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:56:38 INFO - 'work_dir': 'build'} 05:56:38 INFO - [mozharness: 2017-08-24 12:56:38.792339Z] Running clobber step. 05:56:38 INFO - Running pre-action listener: _resource_record_pre_action 05:56:38 INFO - Running main action method: clobber 05:56:38 INFO - rmtree: /builds/slave/test/build 05:56:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:56:39 INFO - Running post-action listener: _resource_record_post_action 05:56:39 INFO - [mozharness: 2017-08-24 12:56:39.823514Z] Finished clobber step (success) 05:56:39 INFO - [mozharness: 2017-08-24 12:56:39.823612Z] Running read-buildbot-config step. 05:56:39 INFO - Running pre-action listener: _resource_record_pre_action 05:56:39 INFO - Running main action method: read_buildbot_config 05:56:39 INFO - Using buildbot properties: 05:56:39 INFO - { 05:56:39 INFO - "project": "", 05:56:39 INFO - "product": "firefox", 05:56:39 INFO - "who": "ffxbld@noreply.mozilla.org", 05:56:39 INFO - "installer_path": "public/build/target.tar.bz2", 05:56:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 05:56:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:56:39 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 05:56:39 INFO - "stage_platform": "linux64-stylo", 05:56:39 INFO - "basedir": "/builds/slave/test", 05:56:39 INFO - "buildnumber": 55, 05:56:39 INFO - "platform": "ubuntu64_hw_stylo", 05:56:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:56:39 INFO - "slavebuilddir": "test", 05:56:39 INFO - "taskId": "S8HMWgdEQRahkJdRmGT-Qw", 05:56:39 INFO - "branch": "mozilla-central", 05:56:39 INFO - "script_repo_revision": "production", 05:56:39 INFO - "revision": "892c8916ba32b7733e06bfbfdd4083ffae3ca028", 05:56:39 INFO - "slavename": "talos-linux64-ix-074", 05:56:39 INFO - "repo_path": "mozilla-central" 05:56:39 INFO - } 05:56:39 INFO - Finding installer, test and symbols from parent task. 05:56:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8HMWgdEQRahkJdRmGT-Qw'}, attempt #1 05:56:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8HMWgdEQRahkJdRmGT-Qw'}, attempt #1 05:56:40 INFO - Task dependencies: ZAmByIIwSJKylSbIRUWeYQ 05:56:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ'}, attempt #1 05:56:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2 05:56:41 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.test_packages.json 05:56:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.crashreporter-symbols.zip 05:56:41 INFO - Running post-action listener: _resource_record_post_action 05:56:41 INFO - [mozharness: 2017-08-24 12:56:41.303773Z] Finished read-buildbot-config step (success) 05:56:41 INFO - [mozharness: 2017-08-24 12:56:41.303992Z] Running download-and-extract step. 05:56:41 INFO - Running pre-action listener: _resource_record_pre_action 05:56:41 INFO - Running main action method: download_and_extract 05:56:41 INFO - mkdir: /builds/slave/test/build/tests 05:56:41 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')]} 05:56:41 INFO - trying https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.test_packages.json 05:56:41 INFO - Downloading https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:56:41 INFO - Downloaded 989 bytes. 05:56:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:56:41 INFO - Using the following test package requirements: 05:56:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:56:41 INFO - u'common': [u'target.common.tests.zip'], 05:56:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:56:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:56:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:56:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:56:41 INFO - u'mozbase': [u'target.common.tests.zip'], 05:56:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:56:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:56:41 INFO - u'web-platform': [u'target.common.tests.zip', 05:56:41 INFO - u'target.web-platform.tests.tar.gz'], 05:56:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:56:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:56:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.common.tests.zip 05:56:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:56:41 INFO - Fetch https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.common.tests.zip into memory 05:56:43 INFO - Content-Length response header: 54979621 05:56:43 INFO - Bytes received: 54979621 05:56:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:56:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.common.tests.zip 05:56:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:56:54 INFO - Fetch https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.common.tests.zip into memory 05:56:55 INFO - Content-Length response header: 54979621 05:56:55 INFO - Bytes received: 54979621 05:57:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.talos.tests.zip 05:57:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:57:07 INFO - Fetch https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.talos.tests.zip into memory 05:57:07 INFO - Content-Length response header: 14496384 05:57:07 INFO - Bytes received: 14496384 05:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:08 INFO - trying https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2 05:57:08 INFO - Downloading https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:57:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:57:09 INFO - Downloaded 60928178 bytes. 05:57:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2 05:57:09 INFO - mkdir: /builds/slave/test/properties 05:57:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:57:09 INFO - Writing to file /builds/slave/test/properties/build_url 05:57:09 INFO - Contents: 05:57:09 INFO - build_url:https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2 05:57:09 INFO - Running post-action listener: _resource_record_post_action 05:57:09 INFO - Running post-action listener: find_tests_for_verification 05:57:09 INFO - Running post-action listener: set_extra_try_arguments 05:57:09 INFO - [mozharness: 2017-08-24 12:57:09.216912Z] Finished download-and-extract step (success) 05:57:09 INFO - [mozharness: 2017-08-24 12:57:09.217010Z] Running populate-webroot step. 05:57:09 INFO - Running pre-action listener: _resource_record_pre_action 05:57:09 INFO - Running main action method: populate_webroot 05:57:09 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:57:09 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 05:57:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:57:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:57:09 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 05:57:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:57:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:57:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:57:09 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:57:09 INFO - 'talos_options': ['--stylo'], 05:57:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:57:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:57:09 INFO - 'tests': ['damp', 'tps']}, 05:57:09 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:57:09 INFO - 'talos_options': ['--stylo'], 05:57:09 INFO - 'tests': ['damp', 'tps']}, 05:57:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:57:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:57:09 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 05:57:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:57:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:57:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:57:09 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:57:09 INFO - 'talos_options': ['--stylo'], 05:57:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:57:09 INFO - 'other-e10s': {'tests': ['a11yr', 05:57:09 INFO - 'ts_paint', 05:57:09 INFO - 'tpaint', 05:57:09 INFO - 'sessionrestore', 05:57:09 INFO - 'sessionrestore_many_windows', 05:57:09 INFO - 'sessionrestore_no_auto_restore', 05:57:09 INFO - 'tabpaint']}, 05:57:09 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 05:57:09 INFO - 'tests': ['a11yr', 05:57:09 INFO - 'ts_paint', 05:57:09 INFO - 'tpaint', 05:57:09 INFO - 'sessionrestore', 05:57:09 INFO - 'sessionrestore_many_windows', 05:57:09 INFO - 'sessionrestore_no_auto_restore', 05:57:09 INFO - 'tabpaint']}, 05:57:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:57:09 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:57:09 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 05:57:09 INFO - 'tests': ['bloom_basic_singleton']}, 05:57:09 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 05:57:09 INFO - 'tests': ['bloom_basic']}, 05:57:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:57:09 INFO - 'tsvgr_opacity', 05:57:09 INFO - 'tart', 05:57:09 INFO - 'tscrollx', 05:57:09 INFO - 'tsvg_static']}, 05:57:09 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 05:57:09 INFO - 'tests': ['tsvgx', 05:57:09 INFO - 'tsvgr_opacity', 05:57:09 INFO - 'tart', 05:57:09 INFO - 'tscrollx', 05:57:09 INFO - 'tsvg_static']}, 05:57:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:57:09 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:57:09 INFO - 'talos_options': ['--stylo'], 05:57:09 INFO - 'tests': ['tp5o']}, 05:57:09 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:57:09 INFO - 'talos_options': ['--mitmproxy', 05:57:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:57:09 INFO - '--firstNonBlankPaint'], 05:57:09 INFO - 'tests': ['tp6_google', 05:57:09 INFO - 'tp6_youtube', 05:57:09 INFO - 'tp6_amazon', 05:57:09 INFO - 'tp6_facebook']}, 05:57:09 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:57:09 INFO - 'talos_options': ['--stylo', 05:57:09 INFO - '--mitmproxy', 05:57:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:57:09 INFO - '--firstNonBlankPaint'], 05:57:09 INFO - 'tests': ['tp6_google', 05:57:09 INFO - 'tp6_youtube', 05:57:09 INFO - 'tp6_amazon', 05:57:09 INFO - 'tp6_facebook']}, 05:57:09 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:57:09 INFO - 'talos_options': ['--stylo', 05:57:09 INFO - '--stylo-threads=1', 05:57:09 INFO - '--mitmproxy', 05:57:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:57:09 INFO - '--firstNonBlankPaint'], 05:57:09 INFO - 'tests': ['tp6_google', 05:57:09 INFO - 'tp6_youtube', 05:57:09 INFO - 'tp6_amazon', 05:57:09 INFO - 'tp6_facebook']}, 05:57:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:57:09 INFO - 'talos_options': ['--xperf_path', 05:57:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:57:09 INFO - 'tests': ['tp5n']}, 05:57:09 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:57:09 INFO - 'talos_options': ['--stylo', 05:57:09 INFO - '--xperf_path', 05:57:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:57:09 INFO - 'tests': ['tp5n']}}} 05:57:09 INFO - Running post-action listener: _resource_record_post_action 05:57:09 INFO - [mozharness: 2017-08-24 12:57:09.231241Z] Finished populate-webroot step (success) 05:57:09 INFO - [mozharness: 2017-08-24 12:57:09.231330Z] Running create-virtualenv step. 05:57:09 INFO - Running pre-action listener: _resource_record_pre_action 05:57:09 INFO - Running main action method: create_virtualenv 05:57:09 INFO - Creating virtualenv /builds/slave/test/build/venv 05:57:09 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:57:09 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 05:57:09 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:57:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:57:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:57:09 INFO - Installing distribute.............................................................................................................................................................................................done. 05:57:10 INFO - Installing pip...............done. 05:57:10 INFO - Return code: 0 05:57:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:57:10 INFO - Reading from file tmpfile_stdout 05:57:10 INFO - Output received: 05:57:10 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 05:57:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2685a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826130>, '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 0x2827030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28274c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', '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 05:57:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:57:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:57:10 INFO - Using env: {'DISPLAY': ':0', 05:57:10 INFO - 'HOME': '/home/cltbld', 05:57:10 INFO - 'LANG': 'en_US.UTF-8', 05:57:10 INFO - 'LANGUAGE': 'en_US:en', 05:57:10 INFO - 'LOGNAME': 'cltbld', 05:57:10 INFO - 'MAIL': '/var/mail/cltbld', 05:57:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:10 INFO - 'MOZ_NO_REMOTE': '1', 05:57:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:10 INFO - 'NO_EM_RESTART': '1', 05:57:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:10 INFO - 'PWD': '/builds/slave/test', 05:57:10 INFO - 'SHELL': '/bin/bash', 05:57:10 INFO - 'SHLVL': '1', 05:57:10 INFO - 'TERM': 'linux', 05:57:10 INFO - 'TMOUT': '86400', 05:57:10 INFO - 'USER': 'cltbld', 05:57:10 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', 05:57:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:10 INFO - '_': '/tools/buildbot/bin/python'} 05:57:11 INFO - Ignoring indexes: http://pypi.python.org/simple/ 05:57:11 INFO - Downloading/unpacking pip>=1.5 05:57:11 INFO - Running setup.py egg_info for package pip 05:57:11 INFO - warning: no files found matching 'pip/cacert.pem' 05:57:11 INFO - warning: no files found matching '*.html' under directory 'docs' 05:57:11 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:57:11 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:57:11 INFO - Installing collected packages: pip 05:57:11 INFO - Found existing installation: pip 1.1 05:57:11 INFO - Uninstalling pip: 05:57:11 INFO - Successfully uninstalled pip 05:57:11 INFO - Running setup.py install for pip 05:57:11 INFO - warning: no files found matching 'pip/cacert.pem' 05:57:11 INFO - warning: no files found matching '*.html' under directory 'docs' 05:57:11 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 05:57:11 INFO - no previously-included directories found matching 'docs/_build/_sources' 05:57:11 INFO - Installing pip script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Successfully installed pip 05:57:11 INFO - Cleaning up... 05:57:11 INFO - Return code: 0 05:57:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:57:11 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')]} 05:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:11 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')]} 05:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:11 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 0x24ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2685a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826130>, '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 0x2827030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28274c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', '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 05:57:11 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 05:57:11 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 05:57:11 INFO - Using env: {'DISPLAY': ':0', 05:57:11 INFO - 'HOME': '/home/cltbld', 05:57:11 INFO - 'LANG': 'en_US.UTF-8', 05:57:11 INFO - 'LANGUAGE': 'en_US:en', 05:57:11 INFO - 'LOGNAME': 'cltbld', 05:57:11 INFO - 'MAIL': '/var/mail/cltbld', 05:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:11 INFO - 'MOZ_NO_REMOTE': '1', 05:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:11 INFO - 'NO_EM_RESTART': '1', 05:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:11 INFO - 'PWD': '/builds/slave/test', 05:57:11 INFO - 'SHELL': '/bin/bash', 05:57:11 INFO - 'SHLVL': '1', 05:57:11 INFO - 'TERM': 'linux', 05:57:11 INFO - 'TMOUT': '86400', 05:57:11 INFO - 'USER': 'cltbld', 05:57:11 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', 05:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:11 INFO - '_': '/tools/buildbot/bin/python'} 05:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:11 INFO - Downloading/unpacking psutil>=3.1.1 05:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:57:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:12 INFO - Installing collected packages: psutil 05:57:12 INFO - Running setup.py install for psutil 05:57:12 INFO - building 'psutil._psutil_linux' extension 05:57:12 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 05:57:13 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 05:57:13 INFO - building 'psutil._psutil_posix' extension 05:57:13 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 05:57:13 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 05:57:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:57:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:57:13 INFO - Successfully installed psutil 05:57:13 INFO - Cleaning up... 05:57:13 INFO - Return code: 0 05:57:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2685a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826130>, '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 0x2827030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28274c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', '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 05:57:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:57:13 INFO - Using env: {'DISPLAY': ':0', 05:57:13 INFO - 'HOME': '/home/cltbld', 05:57:13 INFO - 'LANG': 'en_US.UTF-8', 05:57:13 INFO - 'LANGUAGE': 'en_US:en', 05:57:13 INFO - 'LOGNAME': 'cltbld', 05:57:13 INFO - 'MAIL': '/var/mail/cltbld', 05:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:13 INFO - 'MOZ_NO_REMOTE': '1', 05:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:13 INFO - 'NO_EM_RESTART': '1', 05:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:13 INFO - 'PWD': '/builds/slave/test', 05:57:13 INFO - 'SHELL': '/bin/bash', 05:57:13 INFO - 'SHLVL': '1', 05:57:13 INFO - 'TERM': 'linux', 05:57:13 INFO - 'TMOUT': '86400', 05:57:13 INFO - 'USER': 'cltbld', 05:57:13 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', 05:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:13 INFO - '_': '/tools/buildbot/bin/python'} 05:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:57:14 INFO - Installing collected packages: mozsystemmonitor 05:57:14 INFO - Running setup.py install for mozsystemmonitor 05:57:14 INFO - Successfully installed mozsystemmonitor 05:57:14 INFO - Cleaning up... 05:57:14 INFO - Return code: 0 05:57:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:57:14 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')]} 05:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:14 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')]} 05:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:14 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 0x24ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2685a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826130>, '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 0x2827030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28274c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', '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 05:57:14 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 05:57:14 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 05:57:14 INFO - Using env: {'DISPLAY': ':0', 05:57:14 INFO - 'HOME': '/home/cltbld', 05:57:14 INFO - 'LANG': 'en_US.UTF-8', 05:57:14 INFO - 'LANGUAGE': 'en_US:en', 05:57:14 INFO - 'LOGNAME': 'cltbld', 05:57:14 INFO - 'MAIL': '/var/mail/cltbld', 05:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:14 INFO - 'MOZ_NO_REMOTE': '1', 05:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:14 INFO - 'NO_EM_RESTART': '1', 05:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:14 INFO - 'PWD': '/builds/slave/test', 05:57:14 INFO - 'SHELL': '/bin/bash', 05:57:14 INFO - 'SHLVL': '1', 05:57:14 INFO - 'TERM': 'linux', 05:57:14 INFO - 'TMOUT': '86400', 05:57:14 INFO - 'USER': 'cltbld', 05:57:14 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', 05:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:14 INFO - '_': '/tools/buildbot/bin/python'} 05:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:15 INFO - Downloading/unpacking jsonschema==2.5.1 05:57:15 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 05:57:15 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 05:57:15 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 05:57:15 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 05:57:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:57:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:57:16 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 05:57:16 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 05:57:16 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 05:57:16 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 05:57:16 INFO - Downloading functools32-3.2.3-2.tar.gz 05:57:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:57:16 INFO - warning: no files found matching '*.txt' 05:57:16 INFO - no previously-included directories found matching 'build' 05:57:16 INFO - no previously-included directories found matching 'dist' 05:57:16 INFO - no previously-included directories found matching '.git*' 05:57:16 INFO - Installing collected packages: jsonschema, functools32 05:57:16 INFO - Running setup.py install for functools32 05:57:16 INFO - warning: no files found matching '*.txt' 05:57:16 INFO - no previously-included directories found matching 'build' 05:57:16 INFO - no previously-included directories found matching 'dist' 05:57:16 INFO - no previously-included directories found matching '.git*' 05:57:16 INFO - Successfully installed jsonschema functools32 05:57:16 INFO - Cleaning up... 05:57:16 INFO - Return code: 0 05:57:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:57:16 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')]} 05:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:16 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')]} 05:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:16 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 0x24ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2685a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826130>, '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 0x2827030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28274c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', '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 05:57:16 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 05:57:16 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 05:57:16 INFO - Using env: {'DISPLAY': ':0', 05:57:16 INFO - 'HOME': '/home/cltbld', 05:57:16 INFO - 'LANG': 'en_US.UTF-8', 05:57:16 INFO - 'LANGUAGE': 'en_US:en', 05:57:16 INFO - 'LOGNAME': 'cltbld', 05:57:16 INFO - 'MAIL': '/var/mail/cltbld', 05:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:16 INFO - 'MOZ_NO_REMOTE': '1', 05:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:16 INFO - 'NO_EM_RESTART': '1', 05:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:16 INFO - 'PWD': '/builds/slave/test', 05:57:16 INFO - 'SHELL': '/bin/bash', 05:57:16 INFO - 'SHLVL': '1', 05:57:16 INFO - 'TERM': 'linux', 05:57:16 INFO - 'TMOUT': '86400', 05:57:16 INFO - 'USER': 'cltbld', 05:57:16 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', 05:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:16 INFO - '_': '/tools/buildbot/bin/python'} 05:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:57:16 INFO - Cleaning up... 05:57:16 INFO - Return code: 0 05:57:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:57:16 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')]} 05:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:16 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')]} 05:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:16 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 0x24ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2685a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826130>, '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 0x2827030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28274c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', '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 05:57:16 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 05:57:16 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 05:57:16 INFO - Using env: {'DISPLAY': ':0', 05:57:16 INFO - 'HOME': '/home/cltbld', 05:57:16 INFO - 'LANG': 'en_US.UTF-8', 05:57:16 INFO - 'LANGUAGE': 'en_US:en', 05:57:16 INFO - 'LOGNAME': 'cltbld', 05:57:16 INFO - 'MAIL': '/var/mail/cltbld', 05:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:16 INFO - 'MOZ_NO_REMOTE': '1', 05:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:16 INFO - 'NO_EM_RESTART': '1', 05:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:16 INFO - 'PWD': '/builds/slave/test', 05:57:16 INFO - 'SHELL': '/bin/bash', 05:57:16 INFO - 'SHLVL': '1', 05:57:16 INFO - 'TERM': 'linux', 05:57:16 INFO - 'TMOUT': '86400', 05:57:16 INFO - 'USER': 'cltbld', 05:57:16 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', 05:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:16 INFO - '_': '/tools/buildbot/bin/python'} 05:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:16 INFO - Downloading/unpacking blobuploader==1.2.4 05:57:16 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 05:57:16 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 05:57:16 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 05:57:16 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 05:57:18 INFO - Downloading blobuploader-1.2.4.tar.gz 05:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:57:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:57:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 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 05:57:18 INFO - Downloading docopt-0.6.1.tar.gz 05:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:57:18 INFO - Installing collected packages: blobuploader, requests, docopt 05:57:18 INFO - Running setup.py install for blobuploader 05:57:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:57:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:57:18 INFO - Running setup.py install for requests 05:57:19 INFO - Running setup.py install for docopt 05:57:19 INFO - Successfully installed blobuploader requests docopt 05:57:19 INFO - Cleaning up... 05:57:19 INFO - Return code: 0 05:57:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:19 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')]} 05:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:19 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')]} 05:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:19 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 0x24ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2685a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826130>, '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 0x2827030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28274c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', '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 05:57:19 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 05:57:19 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 05:57:19 INFO - Using env: {'DISPLAY': ':0', 05:57:19 INFO - 'HOME': '/home/cltbld', 05:57:19 INFO - 'LANG': 'en_US.UTF-8', 05:57:19 INFO - 'LANGUAGE': 'en_US:en', 05:57:19 INFO - 'LOGNAME': 'cltbld', 05:57:19 INFO - 'MAIL': '/var/mail/cltbld', 05:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:19 INFO - 'MOZ_NO_REMOTE': '1', 05:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:19 INFO - 'NO_EM_RESTART': '1', 05:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:19 INFO - 'PWD': '/builds/slave/test', 05:57:19 INFO - 'SHELL': '/bin/bash', 05:57:19 INFO - 'SHLVL': '1', 05:57:19 INFO - 'TERM': 'linux', 05:57:19 INFO - 'TMOUT': '86400', 05:57:19 INFO - 'USER': 'cltbld', 05:57:19 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', 05:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:19 INFO - '_': '/tools/buildbot/bin/python'} 05:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:19 INFO - Running setup.py (path:/tmp/pip-jppItr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:19 INFO - Running setup.py (path:/tmp/pip-4wyTCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:19 INFO - Running setup.py (path:/tmp/pip-3qMPyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:19 INFO - Running setup.py (path:/tmp/pip-ehFJgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:19 INFO - Running setup.py (path:/tmp/pip-RFa0zO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:19 INFO - Running setup.py (path:/tmp/pip-tlOYwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:19 INFO - Running setup.py (path:/tmp/pip-MktNzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:20 INFO - Running setup.py (path:/tmp/pip-fP5vXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:20 INFO - Running setup.py (path:/tmp/pip-1F6Ry3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:20 INFO - Running setup.py (path:/tmp/pip-zOCmz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:20 INFO - Running setup.py (path:/tmp/pip-aSIfsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:20 INFO - Running setup.py (path:/tmp/pip-EjVGXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:20 INFO - Running setup.py (path:/tmp/pip-HdJjjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:20 INFO - Running setup.py (path:/tmp/pip-kt5OrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:20 INFO - Running setup.py (path:/tmp/pip-LTxPvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:20 INFO - Running setup.py (path:/tmp/pip-plho4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:20 INFO - Running setup.py (path:/tmp/pip-IB1rRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:57:20 INFO - Running setup.py install for manifestparser 05:57:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:57:20 INFO - Running setup.py install for mozcrash 05:57:21 INFO - Running setup.py install for mozdebug 05:57:21 INFO - Running setup.py install for mozdevice 05:57:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:57:21 INFO - Running setup.py install for mozfile 05:57:21 INFO - Running setup.py install for mozhttpd 05:57:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:57:21 INFO - Running setup.py install for mozinfo 05:57:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:57:21 INFO - Running setup.py install for mozInstall 05:57:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:57:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:57:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:57:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:57:21 INFO - Running setup.py install for mozleak 05:57:21 INFO - Running setup.py install for mozlog 05:57:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:57:21 INFO - Running setup.py install for moznetwork 05:57:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:57:21 INFO - Running setup.py install for mozprocess 05:57:22 INFO - Running setup.py install for mozprofile 05:57:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:57:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:57:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:57:22 INFO - Running setup.py install for mozrunner 05:57:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:57:22 INFO - Running setup.py install for mozscreenshot 05:57:22 INFO - Running setup.py install for moztest 05:57:22 INFO - Running setup.py install for mozversion 05:57:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:57:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:57:22 INFO - Cleaning up... 05:57:22 INFO - Return code: 0 05:57:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:22 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')]} 05:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:22 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')]} 05:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:22 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 0x24ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2685a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826130>, '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 0x2827030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28274c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', '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 05:57:22 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 05:57:22 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 05:57:22 INFO - Using env: {'DISPLAY': ':0', 05:57:22 INFO - 'HOME': '/home/cltbld', 05:57:22 INFO - 'LANG': 'en_US.UTF-8', 05:57:22 INFO - 'LANGUAGE': 'en_US:en', 05:57:22 INFO - 'LOGNAME': 'cltbld', 05:57:22 INFO - 'MAIL': '/var/mail/cltbld', 05:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:22 INFO - 'MOZ_NO_REMOTE': '1', 05:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:22 INFO - 'NO_EM_RESTART': '1', 05:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:22 INFO - 'PWD': '/builds/slave/test', 05:57:22 INFO - 'SHELL': '/bin/bash', 05:57:22 INFO - 'SHLVL': '1', 05:57:22 INFO - 'TERM': 'linux', 05:57:22 INFO - 'TMOUT': '86400', 05:57:22 INFO - 'USER': 'cltbld', 05:57:22 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', 05:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:22 INFO - '_': '/tools/buildbot/bin/python'} 05:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:22 INFO - Running setup.py (path:/tmp/pip-_i0CWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:22 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)) 05:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:22 INFO - Running setup.py (path:/tmp/pip-znBby0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:22 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)) 05:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:22 INFO - Running setup.py (path:/tmp/pip-KObyLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:22 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)) 05:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:22 INFO - Running setup.py (path:/tmp/pip-lfpueW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:23 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)) 05:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:23 INFO - Running setup.py (path:/tmp/pip-ai7TtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:23 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)) 05:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:23 INFO - Running setup.py (path:/tmp/pip-BjIb0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:23 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)) 05:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:23 INFO - Running setup.py (path:/tmp/pip-nwYRa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:23 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)) 05:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:23 INFO - Running setup.py (path:/tmp/pip-_igYit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:23 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)) 05:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:23 INFO - Running setup.py (path:/tmp/pip-WJBDG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:23 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)) 05:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:23 INFO - Running setup.py (path:/tmp/pip-vzgEjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:23 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)) 05:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:23 INFO - Running setup.py (path:/tmp/pip-Hw6Lp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:23 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)) 05:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:23 INFO - Running setup.py (path:/tmp/pip-BTVyaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:23 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)) 05:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:23 INFO - Running setup.py (path:/tmp/pip-hugDq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:23 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)) 05:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:23 INFO - Running setup.py (path:/tmp/pip-IREjkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:23 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)) 05:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:23 INFO - Running setup.py (path:/tmp/pip-GRUfFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:23 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)) 05:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:23 INFO - Running setup.py (path:/tmp/pip-vyk7CN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:23 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)) 05:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:23 INFO - Running setup.py (path:/tmp/pip-wH82dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:23 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)) 05:57:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57:24 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 05:57:24 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 05:57:24 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 05:57:24 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 05:57:25 INFO - Downloading blessings-1.6.tar.gz 05:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:57:25 INFO - Installing collected packages: blessings 05:57:25 INFO - Running setup.py install for blessings 05:57:25 INFO - Successfully installed blessings 05:57:25 INFO - Cleaning up... 05:57:25 INFO - Return code: 0 05:57:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:25 INFO - Reading from file tmpfile_stdout 05:57:25 INFO - Current package versions: 05:57:25 INFO - argparse == 1.2.1 05:57:25 INFO - blessings == 1.6 05:57:25 INFO - blobuploader == 1.2.4 05:57:25 INFO - docopt == 0.6.1 05:57:25 INFO - functools32 == 3.2.3-2 05:57:25 INFO - jsonschema == 2.5.1 05:57:25 INFO - manifestparser == 1.1 05:57:25 INFO - mozInstall == 1.13 05:57:25 INFO - mozcrash == 1.0 05:57:25 INFO - mozdebug == 0.1 05:57:25 INFO - mozdevice == 0.51 05:57:25 INFO - mozfile == 1.2 05:57:25 INFO - mozhttpd == 0.7 05:57:25 INFO - mozinfo == 0.10 05:57:25 INFO - mozleak == 0.1 05:57:25 INFO - mozlog == 3.5 05:57:25 INFO - moznetwork == 0.27 05:57:25 INFO - mozprocess == 0.25 05:57:25 INFO - mozprofile == 0.28 05:57:25 INFO - mozrunner == 6.13 05:57:25 INFO - mozscreenshot == 0.1 05:57:25 INFO - mozsystemmonitor == 0.3 05:57:25 INFO - moztest == 0.8 05:57:25 INFO - mozversion == 1.4 05:57:25 INFO - psutil == 3.1.1 05:57:25 INFO - requests == 1.2.3 05:57:25 INFO - wsgiref == 0.1.2 05:57:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:25 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 0x24ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2685a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826130>, '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 0x2827030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28274c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', '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 05:57:25 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 05:57:25 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 05:57:25 INFO - Using env: {'DISPLAY': ':0', 05:57:25 INFO - 'HOME': '/home/cltbld', 05:57:25 INFO - 'LANG': 'en_US.UTF-8', 05:57:25 INFO - 'LANGUAGE': 'en_US:en', 05:57:25 INFO - 'LOGNAME': 'cltbld', 05:57:25 INFO - 'MAIL': '/var/mail/cltbld', 05:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:25 INFO - 'MOZ_NO_REMOTE': '1', 05:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:25 INFO - 'NO_EM_RESTART': '1', 05:57:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:25 INFO - 'PWD': '/builds/slave/test', 05:57:25 INFO - 'SHELL': '/bin/bash', 05:57:25 INFO - 'SHLVL': '1', 05:57:25 INFO - 'TERM': 'linux', 05:57:25 INFO - 'TMOUT': '86400', 05:57:25 INFO - 'USER': 'cltbld', 05:57:25 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', 05:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:25 INFO - '_': '/tools/buildbot/bin/python'} 05:57:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:25 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)) 05:57:25 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)) 05:57:25 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)) 05:57:25 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)) 05:57:25 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)) 05:57:25 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)) 05:57:25 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)) 05:57:25 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)) 05:57:25 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)) 05:57:25 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:57:25 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 05:57:25 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 05:57:25 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 05:57:25 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 05:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:57:26 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)) 05:57:26 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)) 05:57:26 INFO - Installing collected packages: simplejson 05:57:26 INFO - Running setup.py install for simplejson 05:57:27 INFO - building 'simplejson._speedups' extension 05:57:27 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 05:57:27 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 05:57:27 INFO - Successfully installed simplejson 05:57:27 INFO - Cleaning up... 05:57:28 INFO - Return code: 0 05:57:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:28 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 0x24ba1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2685a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2828f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826130>, '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 0x2827030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28274c0>, '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': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', '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 05:57:28 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 05:57:28 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 05:57:28 INFO - Using env: {'DISPLAY': ':0', 05:57:28 INFO - 'HOME': '/home/cltbld', 05:57:28 INFO - 'LANG': 'en_US.UTF-8', 05:57:28 INFO - 'LANGUAGE': 'en_US:en', 05:57:28 INFO - 'LOGNAME': 'cltbld', 05:57:28 INFO - 'MAIL': '/var/mail/cltbld', 05:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:28 INFO - 'MOZ_NO_REMOTE': '1', 05:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:28 INFO - 'NO_EM_RESTART': '1', 05:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:28 INFO - 'PWD': '/builds/slave/test', 05:57:28 INFO - 'SHELL': '/bin/bash', 05:57:28 INFO - 'SHLVL': '1', 05:57:28 INFO - 'TERM': 'linux', 05:57:28 INFO - 'TMOUT': '86400', 05:57:28 INFO - 'USER': 'cltbld', 05:57:28 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', 05:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:28 INFO - '_': '/tools/buildbot/bin/python'} 05:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:57:28 INFO - Cleaning up... 05:57:28 INFO - Return code: 0 05:57:28 INFO - Running post-action listener: _resource_record_post_action 05:57:28 INFO - Running post-action listener: _start_resource_monitoring 05:57:28 INFO - Starting resource monitoring. 05:57:28 INFO - [mozharness: 2017-08-24 12:57:28.270254Z] Finished create-virtualenv step (success) 05:57:28 INFO - [mozharness: 2017-08-24 12:57:28.270722Z] Running install step. 05:57:28 INFO - Running pre-action listener: _resource_record_pre_action 05:57:28 INFO - Running main action method: install 05:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:28 INFO - Reading from file tmpfile_stdout 05:57:28 INFO - Detecting whether we're running mozinstall >=1.0... 05:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:57:28 INFO - Reading from file tmpfile_stdout 05:57:28 INFO - Output received: 05:57:28 INFO - Usage: mozinstall [options] installer 05:57:28 INFO - Options: 05:57:28 INFO - -h, --help show this help message and exit 05:57:28 INFO - -d DEST, --destination=DEST 05:57:28 INFO - Directory to install application into. [default: 05:57:28 INFO - "/builds/slave/test"] 05:57:28 INFO - --app=APP Application being installed. [default: firefox] 05:57:28 INFO - mkdir: /builds/slave/test/build/application 05:57:28 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'] 05:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:57:46 INFO - Reading from file tmpfile_stdout 05:57:46 INFO - Output received: 05:57:46 INFO - /builds/slave/test/build/application/firefox/firefox 05:57:46 INFO - Running post-action listener: _resource_record_post_action 05:57:46 INFO - [mozharness: 2017-08-24 12:57:46.339798Z] Finished install step (success) 05:57:46 INFO - [mozharness: 2017-08-24 12:57:46.340076Z] Running setup-mitmproxy step. 05:57:46 INFO - Running pre-action listener: _resource_record_pre_action 05:57:46 INFO - Running main action method: setup_mitmproxy 05:57:46 INFO - Skipping: mitmproxy is not required 05:57:46 INFO - Running post-action listener: _resource_record_post_action 05:57:46 INFO - [mozharness: 2017-08-24 12:57:46.341202Z] Finished setup-mitmproxy step (success) 05:57:46 INFO - [mozharness: 2017-08-24 12:57:46.341483Z] Running run-tests step. 05:57:46 INFO - Running pre-action listener: _resource_record_pre_action 05:57:46 INFO - Running pre-action listener: _set_gcov_prefix 05:57:46 INFO - Running main action method: run_tests 05:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:57:46 INFO - Python 2.7.3 05:57:46 INFO - Return code: 0 05:57:46 INFO - grabbing minidump binary from tooltool 05:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:46 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2826130>, '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 0x2827030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28274c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:57:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:57:46 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:57:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:57:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:57:46 INFO - Return code: 0 05:57:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:57:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:57:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:57:46 INFO - ENV: RUST_BACKTRACE is now full 05:57:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:57:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 05:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-074 --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 05:57:46 INFO - Using env: {'DISPLAY': ':0', 05:57:46 INFO - 'HOME': '/home/cltbld', 05:57:46 INFO - 'LANG': 'en_US.UTF-8', 05:57:46 INFO - 'LANGUAGE': 'en_US:en', 05:57:46 INFO - 'LOGNAME': 'cltbld', 05:57:46 INFO - 'MAIL': '/var/mail/cltbld', 05:57:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:57:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:46 INFO - 'MOZ_NO_REMOTE': '1', 05:57:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:57:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:46 INFO - 'NO_EM_RESTART': '1', 05:57:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:46 INFO - 'PWD': '/builds/slave/test', 05:57:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:57:46 INFO - 'RUST_BACKTRACE': 'full', 05:57:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:57:46 INFO - 'SHELL': '/bin/bash', 05:57:46 INFO - 'SHLVL': '1', 05:57:46 INFO - 'STYLO_FORCE_ENABLED': '1', 05:57:46 INFO - 'TERM': 'linux', 05:57:46 INFO - 'TMOUT': '86400', 05:57:46 INFO - 'USER': 'cltbld', 05:57:46 INFO - 'XDG_SESSION_COOKIE': '23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225', 05:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:46 INFO - '_': '/tools/buildbot/bin/python'} 05:57:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-074', '--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 05:57:46 INFO - mozversion application_buildid: 20170824120051 05:57:46 INFO - mozversion application_changeset: 892c8916ba32b7733e06bfbfdd4083ffae3ca028 05:57:46 INFO - mozversion application_display_name: Nightly 05:57:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:57:46 INFO - mozversion application_name: Firefox 05:57:46 INFO - mozversion application_remotingname: firefox 05:57:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:57:46 INFO - mozversion application_vendor: Mozilla 05:57:46 INFO - mozversion application_version: 57.0a1 05:57:46 INFO - mozversion platform_buildid: 20170824120051 05:57:46 INFO - mozversion platform_changeset: 892c8916ba32b7733e06bfbfdd4083ffae3ca028 05:57:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:57:46 INFO - mozversion platform_version: 57.0a1 05:57:46 INFO - using testdate: 1503579466 05:57:46 INFO - actual date: 1503579466 05:57:46 INFO - starting webserver on 'localhost:60861' 05:57:46 INFO - SUITE-START | Running 2 tests 05:57:46 INFO - TEST-START | dromaeo_css 05:57:46 INFO - Initialising browser for dromaeo_css test... 05:57:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60861/getInfo.html -profile /tmp/tmpaXwseE/profile 05:57:46 INFO - TEST-INFO | started process 3830 (/builds/slave/test/build/application/firefox/firefox http://localhost:60861/getInfo.html) 05:57:52 INFO - TEST-INFO | 3830: exit 0 05:57:52 INFO - Browser initialized. 05:57:52 INFO - Running cycle 1/1 for dromaeo_css test... 05:57:52 INFO - TEST-INFO | started process 4014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaXwseE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:53 INFO - PID 4014 | 05:57:53 INFO - PID 4014 | (/builds/slave/test/build/application/firefox/firefox:4064): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:57:53 INFO - PID 4014 | 05:57:54 INFO - PID 4014 | 05:57:54 INFO - PID 4014 | (/builds/slave/test/build/application/firefox/firefox:4123): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:57:54 INFO - PID 4014 | 05:57:54 INFO - PID 4014 | __metrics Screen width/height:1600/1200 05:57:54 INFO - PID 4014 | colorDepth:24 05:57:54 INFO - PID 4014 | Browser inner width/height: 1024/768 05:57:54 INFO - PID 4014 | __metrics 05:58:03 INFO - PID 4014 | RSS: Main: 174813184 05:58:03 INFO - PID 4014 | 06:01:02 INFO - PID 4014 | Cycle 1(1): loaded http://localhost:60861/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60861/tests/dromaeo/cssquery-ext.html) 06:01:03 INFO - PID 4014 | RSS: Main: 178065408 06:01:03 INFO - PID 4014 | 06:04:05 INFO - PID 4014 | Cycle 1(1): loaded http://localhost:60861/tests/dromaeo/cssquery-ext.html (next: http://localhost:60861/tests/dromaeo/cssquery-jquery.html) 06:04:06 INFO - PID 4014 | RSS: Main: 174759936 06:04:06 INFO - PID 4014 | 06:07:07 INFO - PID 4014 | Cycle 1(1): loaded http://localhost:60861/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60861/tests/dromaeo/cssquery-mootools.html) 06:07:08 INFO - PID 4014 | RSS: Main: 177160192 06:07:08 INFO - PID 4014 | 06:10:10 INFO - PID 4014 | Cycle 1(1): loaded http://localhost:60861/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60861/tests/dromaeo/cssquery-prototype.html) 06:10:11 INFO - PID 4014 | RSS: Main: 175042560 06:10:11 INFO - PID 4014 | 06:13:14 INFO - PID 4014 | Cycle 1(1): loaded http://localhost:60861/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60861/tests/dromaeo/cssquery-yui.html) 06:13:15 INFO - PID 4014 | RSS: Main: 179146752 06:13:15 INFO - PID 4014 | 06:16:17 INFO - PID 4014 | Cycle 1(1): loaded http://localhost:60861/tests/dromaeo/cssquery-yui.html (next: http://localhost:60861/tests/dromaeo/cssquery-dojo.html) 06:16:17 INFO - PID 4014 | RSS: Main: 179699712 06:16:17 INFO - PID 4014 | 06:16:17 INFO - PID 4014 | __start_tp_report 06:16:17 INFO - PID 4014 | _x_x_mozilla_page_load 06:16:17 INFO - PID 4014 | _x_x_mozilla_page_load_details 06:16:17 INFO - PID 4014 | |i|pagename|runs| 06:16:17 INFO - PID 4014 | |0;dojo.html;3273.9999999999986;3281.5077738339246;3304.15743985284;3320.950185747214;3321.2361156933903;6081.3918608139165;6121.051237058252;6151.077338399243;6187.226596675416;6246.250449946007;6099.054646529795;6143.078538219258;6166.907496387546;6200.3179650238435;6200.596961197531;5686.9146962795485;5712.22884910538;5803.970980145094;5805.709714514279;5818.040023396155;5644.7459864306;5755.165501002352;5785.739641716133;5857.472827445529;5860.589758716891;5675.574331925101;5713.457221563945;5775.075987841946;5810.767569297223;5843.561732870031;5641.548676105943;5654.264945557093;5708.800191993302;5757.884842303172;5783.2192653992015;5707.486326230618;5709.314882214161;5714.828555143353;5715.142728590703;5717.771289148429;6095.268567771852;6149.169862068608;6198.194234749454;6211.285702144266;6214.5649804513705;6453.612783233021;6597;6683.0977817994435;6730.899036514456;6740.427063699592;6470.57941233823;6589.374009469093;6709.630970296632;6710.966445167792;6715.294894036154;6223.844403889849;6279.717412716439;6306.306306306303;6306.716197771066;6320;6787.490938179656;6859.794206173823;6937.965310173417;6979.8604027919155;6992.510524263253;6298.401651843067;6414.807555773335;6594.835129121714;6668.199816022011;6674.23246326669;6627.1716035495565;6663.20041595002;6712.228093769279;6714.261431242559;6721.361470660279;6600.207975043026;6601.504887133484;6647.700853461509;6667.999800029937;6687.431568316651;6531.608103513804;6625.0724898514245;6633.170853643294;6634.800955971328;6636.203655561363;5188.688678679291;5191.974040129775;5196.272521846944;5212.478752124757;5335.359756829128;4641.025384669189;4673.719576825333;4676.298555216745;4689.1559519286175;4693.95306046942;5824.3302020267365;5834.912476312858;5900.704964751745;5905.498032667271;5920.644761314335;6579.703913323912;6671;6684.064231007663;6686.7993960181275;6690.732370705215;5772.134179872969;5775.624584402084;5789.768409263583;5795.159701843209;5797.8550536236935;5593.916091258634;5629.380768115504;5650.7174641267775;5658.264425624642;5674.404187560329;5998.640081595118;6430.131932189188;6473.255575608771;6592.736290548324;6599.307072757291;6674.2658307586125;6706.966465167643;6718.160229971254;6791.320867913169;6792.626405547742;6401.423871851555;6504.772332968323;6516.51126165549;6578.703958321983;6596.67016649156;6417.839554011187;6439.645819479973;6440.452561532322;6442.323556026738;6456.644884531396;6534.607923524603;6549.508786840911;6554.967225163844;6590.143281373391;6596;6154.476869466145;6341.334159913143;6371.840703982438;6493.675316234075;6548.3124271952665;6425.710843012169;6494.967525162344;6540.50946179029;6575.704093315908;6590.637514936724;6380.361963803768;6405.807825765234;6408.775692850728;6452.645104519296;6490.967545162244;6561.048647946117;6567.44176744982;6569.770058047945;6585.6377899216;6593.175853018372;6285.685715714288;6372.713227904663;6378.3621637837705;6383.457406120346;6392.712327945161 06:16:17 INFO - PID 4014 | |1;ext.html;796.6773456750014;838.1283465196195;866.0906048648919;868.1015149320451;1107.8393632923232;29317.2670683233;29893;38338;38863.61136388635;38922.61077389225;39675.40486892699;40000.599994000055;40021.39967900484;40023.79988100055;40056.59943400565;7256.927430725678;7571.053618297727;7720.382369410434;7736.458447908649;7851.685932562691;7675.616219189046;7747.806304842367;7754;7758.379329653642;7789.454738168331;7722.459427840054;7770.650320735581;7815.6482958267015;7817.2964433201005;7819.335356494705;7726.575038372887;7780.727674531364;7786.182450842665;7787.3770098392;7788.961055194716;7623.618819059025;7684.423668224906;7690.2694244046725;7693.346065584432;7706.190849960785;35760.64239357625;35944;35949.46075808839;35962.82018589917;36023.63976360229;3452.9309413811584;3468.8959331220103;3476.721862251014;3482.564679415073;3484.5121682964404;30201.546976795365;30257.848710756527;30366.84816575925;30562.54156187659;30595.38809223803;5097.8215762448135;5105.336306280197;5114.718690472023;5122.564582010534;5155.510226528511;179481;180688;180815;181006;181098.09450952793;45721.31418028732;45789.084218315445;45830.31254531185;45858.312125318145;45860.08279834384;47436.288455673195;47533;47579;47599.5240047602;47711.5228847714;15419;15603.453879114177;15617.297221625055;15679.451219207273;15721.921390393203;11650.76698466043;11781.469833857496;12646.494140234472;12654.746905061847;12919.418626161845;13499.865001350057;13520.18878867271;13581.320933953262;13594.86405135936;13699.178049316874;5440.91838622421;5586.329640443091;5650.446127315021;5701.287339082614;5752.28096487939;998.7503124218945;1015.3755440404099;1030.2479190191202;1034.9327293725885;1042.1454407386022;22177.55644887093;22597.887010564842;22867.656985145237;22894.771052289263;22933.967971441325;1103.9448027598748;1123.2474242257706;1125.5216532973454;1129.6272230164027;1129.8813624569466;11728.530858765555;12089.516419343303;12157.878421215852;12175.512979480898;12262.877371226352;207626;207785;208164;208268;209921;48000.7599961998;48216.758916205195;48278;48784.26823597649;48816.511834881196;1365.6995460998564;1448.2324368084933;1451.4629587052857;1454.0766613200483;1457.890658200618;21775.564488710454;22011.559768804855;22383;22456.32631021072;22592.887035564716;35953.82023089868;36076.09809754777;36109.63890361063;36111.27777444489;36118.09704757402;180272;180563;180717.0964145171;181055;181743;29548.55677164801;30061.248468788453;32628;32691.182720432178;32723;40737.38893916534;40914.38628420635;40984.385234220914;40999;41069.38395924004;29712.257193570334;30137.547936781404;30174.547381788852;30550.694493054783;31202.687973119977;30092.247693806956;30174.09477715672;30591.316168238925;30681.386372272875;31645.05064848058;34172.48741268833;34281.48577771385;34310;34331.65668343285;34514;29377.265568360108;29534.734990806584;29651.110466686034;29681.25796855096;30119.3976120472;22524.662130067733;22639.547209056054;22906.31281061571;23082.76917230806;23264.185753498547 06:16:17 INFO - PID 4014 | |2;jquery.html;547.3322546493276;551.1842473139756;559.9860003499912;566.3883006353142;581.8109114537775;21693;22510.437239069033;22536.88731556344;22589.209377671785;22662.88668556657;24900;25428.872855635695;25500.36249093769;25524;25580.744192558115;6350.301466838644;6468.353164683541;6468.611883286994;6525.086487891699;6533.31400202979;5921.993261145594;6196.442320191182;6322.968385158068;6425.903611445832;6453.161089058416;6376.107344971708;6384.872302553946;6388.840278993016;6393.200849893763;6393.296737358887;6369.458596019297;6374.426301632852;6405.807825765211;6415.679216039202;6417.582857114273;5906.675132867691;5908.852278693067;5941.346451890288;5944.940550594482;5957.165996760457;28161;28527.85736071327;28631.28421789451;28909;29276;2016.5865997470482;2054.5171884607253;2055.7533096028424;2058.7941205879292;2060.1965233558926;18129.637407251783;18963.24147034117;19035.14341854606;19107.90446047761;19134.42596722087;2311;2372.240882917467;2372.6559648850994;2374.8693821839793;2461.2247142150163;133823;136379;136726;136753;136772.999999999;14041.78937315941;14850.480233191787;14873.181974991263;14913.552593422215;15241.618959525878;23030.309090727304;23037.424064398525;23049.19327823518;23095;23102.42243943915;9844.261680374;9915.355501892354;10066.496675166212;10089.142422893989;10146.08685218319;9105.77235569116;9106.134917182857;9110.544472776335;9168.724938251864;9238.168564829197;7708.961455192801;9059.81880362389;9109.635614575343;9155;9169.449833010041;2703.6620422447195;2755.2973991632407;2755.917322480329;2756.54517004696;2861.6852146263896;928.3872644054892;941.430434587065;960.4669408478362;975.4293738163254;976.7167521418709;19224.71162932557;19290.807091929182;19324;19423.611527769648;19731.210751569775;1004.7287232447198;1004.9648262310784;1031.4224034540682;1032.0866033560203;1038.3199004651965;10548.894511054945;10846.023857852831;10893.509792059376;10919.235653504178;10949.343039417661;482302;488577;496730;500659;502429;111875;117022.41488792501;118465;120380;120565.39717301357;1162.1400163878668;1163.662537864027;1213.5691829400612;1215.3012018089457;1220.4263995921901;20410.59178816445;20528.38414847557;20696.586068278248;20717.171313147304;21944.231951881608;56685.71657141688;57411;57600;59356.703216485366;60149.699251503465;69570.30429695638;69899.65050174716;70253.29746702671;70828.29171708217;71502;13976.440942362191;14465.059771114844;14468.27658617086;14605.85394146045;14784;23683.289501314986;23686.763132369146;23686.763132369146;23793.167239146547;23981;18157.819741716747;18334.81665183331;18582.163802629184;18597.163127659016;18612.06939653039;16019.679606408039;16346.346146154021;16632.91683541623;17106.401275955282;17676.381326653507;18736.906315468335;18982.810171898105;19032.904835475732;19127.04364781783;19134.330298439487;14164.220967846868;14296.285185740879;14307.57077287683;14335.78496322577;14358.425662973781;18478.353257635918;18495.53761155982;18642.906785465984;18988.525286867385;19026.238950441828 06:16:17 INFO - PID 4014 | |3;mootools.html;1264.6775072356547;1332.5669157523807;1333.4266265505828;1334.6263046347026;1338.7121768819704;14588.635284117903;15709;15718.37126514941;15745.685086298266;15783.053016818998;15413.691726165498;15668.921655391707;15671;15705.921470392632;15711.528654140395;2572.2926195296304;2609.9347516312055;2610.2952202905203;2613.882375293107;2615.947681046378;2487.5273697997413;2549.1332946798084;2585.108137692493;2592.377829320959;2593.222033389985;2528.9241322760254;2729.672439307286;2744.656917885264;2745.135282386042;2745.629340039099;2562.6796650418696;2586.5990771430456;2686.865656717166;2741.972580274202;2761.1716485054503;2467.9136230232034;2491.5141547398266;2494.1769216158805;2494.4761600064007;2499.8625075620835;14422.206778627171;14445.855541444662;14559.49041783543;14577.416903323854;14600.196989165592;7528.849423011564;7770.883436748397;7787.3770098392;7791.883121753178;7800.960995195044;5116.360454943132;5184.144616138333;5293.708846013467;5367.355917289911;5385.838424847261;1644.8930819496813;1705.0792572011098;1808.0688445450603;1815.4462888818905;1850.1396850464598;23333.766662333328;23378.064877404882;24642.876785616136;25197.874010630014;25212;6339.461145802658;6349.174607301022;6371.745130194833;6512.869742605216;6530.379613936669;16754.74867876983;16793;16795.91602041982;16805.747913781302;16820.327186912386;7386.2613738625705;7564.394848412114;7567.432442566829;7575.848483030309;7589.544627322378;6889.414399776075;6984.4412447004115;7042.507024508235;7066.187388450291;7105.147382314052;4965.45380008206;5109.4379618241965;5124.12889808726;5132.486751324837;5149.2276158576515;1428.9642758931109;1454.8326942401548;1502.1662977047843;1512.3874830693587;1518.7494063479623;852.2074470742145;860.3332417376583;873.2969959182792;874.873143394217;881.4402854187637;7898;7933.127355990837;8096.676132954616;8109.513429194267;8139.593020349077;955.6559638530124;982.5529384130203;993.6770549571273;996.1582462818907;1002.9398236105711;5223.764930578057;5459.454054594509;5460.645058071213;5526.834194974077;5591.608587398924;20622.484437889172;21626.35120946374;21627.67558486624;21664.783352166593;21696;20163.871399397758;20987.8950605246;21007.78992210089;21058.47353816136;21454.425468943828;10712.464376781285;10986.230963832455;11069.667909962553;11075.612353567747;11086.889131108746;8494.405391622528;8857.601407936787;9011.369204155908;9083.36416450842;9135.63457461694;17772.644547109245;18363.265469381076;18388.54028649241;18642;18763.812361876207;18245.270189192284;18984.620307594047;19136.13887375099;19159.616807664046;19220;11753.353565553634;12186.451609677408;12197.451114700038;12200.633980980585;12205;13243.20540767557;13596.320183990563;13604.863951360756;13662.521811736542;13700.314984250947;9623.422594644344;11311.264767790068;11423.428828558704;11463;11637.941810290895;10926.726831829268;10940.343579385262;10978.341299522055;11124.165687573302;11251.549938002716;9959.352642078242;10091;10110.949445253022;10113.64602238918;10116.1401280889;7350.338469537767;7451.701931922879;7453.366463850633;7631.427642926692;7673.501222420525;7789.961050194713;7793.2596403341595;7850.489718168529;7939.206079392246;7962.363010958993 06:16:17 INFO - PID 4014 | |4;prototype.html;500.7571327905966;501.8658477806101;513.8586888605631;521.6296429535031;526.9815556455525;6226.489556742282;6288.276848162463;6297.496200303976;6300.716467758951;6364.618122912617;5941.43556362146;6104.35904230055;6162.198914141155;6173.753049878011;6198.907016394746;4946.869364080988;4987.376577927759;5006.749662516878;5014.899702005958;5023.799048038074;4948.5298896604945;5032.194848824189;5033.84898453047;5059.873503162414;5074.162763144095;5008.874778130539;5009.599232061426;5011.84964451067;5028.899422011557;5055.46917573655;4997.525235102659;5008.449070602231;5016.297718319438;5025.14572522672;5040.1179793535985;4504.842330518449;4521.773911304422;4521.909561808746;4531.864044078683;4543.5002149763495;6219.564630475868;6234.812955611339;6262.749490020439;6276;6288.213973253343;5666.235058267122;5682.943170568283;5695.231143795576;5784.1902133701315;5784.479396854304;6482.573833756566;6609.372109649576;6622.470202383798;6623.569467984566;6645.6344901030425;4879.414470263591;4879.609631229493;4889.633277504201;4890.117304837628;4909.975450122763;6884.827879303058;6925.480588955848;6969.863561397391;7022.964885175593;7024.683889224997;5010.924836127461;5026.944341688213;5027.1705168647495;5028.698278103326;5032.83588057139;5115.772214668527;5132.717700526507;5135.922961155586;5140.228965655182;5150.510701483353;5690.971545142248;5736.741846616912;5741.1388291756575;5743.3395159557185;5751.396103409165;6498.252700939358;6499.447546958561;6547.148870646881;6564.343565643493;6579.736810527525;1635.8527732503894;1647.8629745475585;1679.8576967662107;1686.957826054334;1746.3887639326135;1202.3807739014414;1225.1179151011258;1226.8711785262597;1228.5761412312916;1241.1126044877956;5858.326292476335;5866.413358664185;5866.50134738552;5882.794102206402;5885.823425297248;6663.533552651268;6739.898901516482;6825;6862;6882.5870447773295;5873.911891321633;5889.204957330791;5894.469497745138;5894.941050589439;5917.408259174048;3583.372909740785;3612;3616.6021737608844;3638.508801311789;3643.599204087548;6652.600843949379;6661;6677.632730199885;6684.565503242274;6701.195856497252;6993.510454268254;7000.299970002959;7002.424454497799;7005.684744186524;7027.824304392431;6634.237062737847;6647.069410282467;6666.066750654815;6722.697478613474;6724.596524208563;6869.900815869637;6892.448604111559;6899.931000689929;6904.792856214322;6917.23910369869;6768.830779230559;6793.150856142982;6809.761658342132;6817;6843;6536.248331441755;6634.966825166036;6650.135482387453;6684.16447944007;6702.765403210864;4961;4985.177445721561;4999;5009.1966891918155;5027.974860125676;6531.673416329069;6594.769183078569;6646.468282537288;6719.942426196167;6740.157480314961;6233.688315584112;6358.427741503102;6417.197850268716;6458.935410646021;6541.476681865344;6510.316416776171;6532.771353002622;6547.803565893031;6565.80302590923;6602.372774586406;6368.688282093378;6412.2625898022325;6429.8714025720155;6455.644939528371;6540.37866402691;6618.338166183536;6655.866882662222;6661.866762664817;6689.531732778853;6710.530262881747;6429.22849258092;6435.388638079375;6447.387498187664;6473.255575608865;6520.608763474207 06:16:17 INFO - PID 4014 | |5;yui.html;872.2150064941547;881.2245224202703;894.7449976756624;897.1745993685809;907.9682211122612;16058.83941160588;16554.92392994456;16571.254293556787;16745.330186792515;17149.485515434524;15849.524514264562;16258.674826503462;16829.242684079214;20571.382858514233;20739.377818665427;926.1433174313767;944.9527523623825;946.1059298962483;946.3375637054055;949.0699114867434;870.2602787630527;948.4830767231841;949.1979277510493;950.9191718703919;952.757046953026;1002.8345323021692;1009.8283291840405;1011.5599714124379;1012.4279781923227;1012.4836333469947;996.4469719305782;1000.0849222961054;1005.1807776661997;1005.5625802775779;1005.8038682456961;723.8914162875558;729.6935287179398;734.8640501507239;737.7934178430048;738.199054026382;17671.73492397615;18460.169292381874;18831.529211769677;19246.615067698567;19254.518637034045;20177.79822201774;20232.79767202324;20669.276575319942;20705.792942070686;21051.68422473664;16172.75740863888;16229.431969881116;16340.75488867668;16428.507144785675;16447.506574802774;3684.336819372512;3732.6267373262726;3751.643593858579;3752.587215406303;3754.8498060077563;123780;125090;125668;127813.36093319567;128121;12443.502259909503;12452.439640216213;12589.24464532131;12599.748005039848;12677.492900283885;29372.265693357836;29941.40117197644;30022.39955200884;30032.39935201284;30087.097387078422;8319.292860106958;8350.33197344211;8662.91337086621;8762.86855697165;8824.338174636929;3917.334053210961;3987.9003024924027;3990.620891015349;3991.3613821788954;4013.1171142348635;4650.302454631832;5577.972110139423;5664.065429204135;5762.538996880324;5765.509931655856;1068.1935138970027;1077.3051381858656;1103.5309993252836;1106.397013627575;1110.306058713304;692.3630260160563;700.8738427083174;706.251373544045;712.0529695504966;715.8425146467769;11378.886211137948;11842.230255033395;12019.158658893793;13049.934750326378;13146.079774415699;678.5487650712221;679.966001699913;690.7444245629149;694.5069001009239;698.1308271202386;5725.2843394575675;5751.281089863767;5814.244148260699;5830.883382332329;5867.970660146757;109347;111685;111779;113315;114825;92372.53813730889;93213;93797.5310123445;95567;96286;79291.60354198307;91522;92104.53947730352;92450.53774731084;94178;12624.684382890502;12806;12937.223766574036;12964.481420743065;12997.285149316878;40872.18255634811;42165.78917105395;42304.365434517895;42596.78701606472;43053.3541996864;72197.27802721906;73384;74869.25130748622;75236;77782;17580.208890599697;17973.101344932962;18124.45626631203;18351.816481835012;18360;21405.143794248677;21468.35594932092;21537.784622153576;21609.891950540146;21687.674684879425;18288;18573.90713046426;18664.906675466536;19228;19322.710159347902;17131.229094691018;17174.22715977759;19699.40901772949;19938.800611993694;20103.59792804165;18607.162677679265;18669.43991680252;19575.412737617895;19922.50193745168;20108.09513571922;12429.564965226175;12571.308578028296;12880.162789418659;12985.091043626855;13207.273599952096;13860.514881979485;13905.37425815861;13970.231637260049;14070.859291407365;14309.785353219502 06:16:17 INFO - PID 4014 | __end_tp_report 06:16:17 INFO - PID 4014 | __start_cc_report 06:16:17 INFO - PID 4014 | _x_x_mozilla_cycle_collect,347 06:16:17 INFO - PID 4014 | __end_cc_report 06:16:17 INFO - PID 4014 | __startTimestamp1503580577442__endTimestamp 06:16:17 INFO - PID 4014 | 06:16:17 INFO - PID 4014 | ------- Summary: start ------- 06:16:17 INFO - PID 4014 | Number of tests: 6 06:16:17 INFO - PID 4014 | 06:16:17 INFO - PID 4014 | [#0] dojo.html Cycles:165 Average:6130.15 Median:6378.36 stddev:701.23 (11.0%) stddev-sans-first:666.62 06:16:17 INFO - PID 4014 | Values: 3274.0 3281.5 3304.2 3321.0 3321.2 6081.4 6121.1 6151.1 6187.2 6246.3 6099.1 6143.1 6166.9 6200.3 6200.6 5686.9 5712.2 5804.0 5805.7 5818.0 5644.7 5755.2 5785.7 5857.5 5860.6 5675.6 5713.5 5775.1 5810.8 5843.6 5641.5 5654.3 5708.8 5757.9 5783.2 5707.5 5709.3 5714.8 5715.1 5717.8 6095.3 6149.2 6198.2 6211.3 6214.6 6453.6 6597.0 6683.1 6730.9 6740.4 6470.6 6589.4 6709.6 6711.0 6715.3 6223.8 6279.7 6306.3 6306.7 6320.0 6787.5 6859.8 6938.0 6979.9 6992.5 6298.4 6414.8 6594.8 6668.2 6674.2 6627.2 6663.2 6712.2 6714.3 6721.4 6600.2 6601.5 6647.7 6668.0 6687.4 6531.6 6625.1 6633.2 6634.8 6636.2 5188.7 5192.0 5196.3 5212.5 5335.4 4641.0 4673.7 4676.3 4689.2 4694.0 5824.3 5834.9 5900.7 5905.5 5920.6 6579.7 6671.0 6684.1 6686.8 6690.7 5772.1 5775.6 5789.8 5795.2 5797.9 5593.9 5629.4 5650.7 5658.3 5674.4 5998.6 6430.1 6473.3 6592.7 6599.3 6674.3 6707.0 6718.2 6791.3 6792.6 6401.4 6504.8 6516.5 6578.7 6596.7 6417.8 6439.6 6440.5 6442.3 6456.6 6534.6 6549.5 6555.0 6590.1 6596.0 6154.5 6341.3 6371.8 6493.7 6548.3 6425.7 6495.0 6540.5 6575.7 6590.6 6380.4 6405.8 6408.8 6452.6 6491.0 6561.0 6567.4 6569.8 6585.6 6593.2 6285.7 6372.7 6378.4 6383.5 6392.7 06:16:17 INFO - PID 4014 | 06:16:17 INFO - PID 4014 | [#1] ext.html Cycles:180 Average:35146.01 Median:32707.09 stddev:49175.82 (150.4%) stddev-sans-first:49246.13 06:16:17 INFO - PID 4014 | Values: 796.7 838.1 866.1 868.1 1107.8 29317.3 29893.0 38338.0 38863.6 38922.6 39675.4 40000.6 40021.4 40023.8 40056.6 7256.9 7571.1 7720.4 7736.5 7851.7 7675.6 7747.8 7754.0 7758.4 7789.5 7722.5 7770.7 7815.6 7817.3 7819.3 7726.6 7780.7 7786.2 7787.4 7789.0 7623.6 7684.4 7690.3 7693.3 7706.2 35760.6 35944.0 35949.5 35962.8 36023.6 3452.9 3468.9 3476.7 3482.6 3484.5 30201.5 30257.8 30366.8 30562.5 30595.4 5097.8 5105.3 5114.7 5122.6 5155.5 179481.0 180688.0 180815.0 181006.0 181098.1 45721.3 45789.1 45830.3 45858.3 45860.1 47436.3 47533.0 47579.0 47599.5 47711.5 15419.0 15603.5 15617.3 15679.5 15721.9 11650.8 11781.5 12646.5 12654.7 12919.4 13499.9 13520.2 13581.3 13594.9 13699.2 5440.9 5586.3 5650.4 5701.3 5752.3 998.8 1015.4 1030.2 1034.9 1042.1 22177.6 22597.9 22867.7 22894.8 22934.0 1103.9 1123.2 1125.5 1129.6 1129.9 11728.5 12089.5 12157.9 12175.5 12262.9 207626.0 207785.0 208164.0 208268.0 209921.0 48000.8 48216.8 48278.0 48784.3 48816.5 1365.7 1448.2 1451.5 1454.1 1457.9 21775.6 22011.6 22383.0 22456.3 22592.9 35953.8 36076.1 36109.6 36111.3 36118.1 180272.0 180563.0 180717.1 181055.0 181743.0 29548.6 30061.2 32628.0 32691.2 32723.0 40737.4 40914.4 40984.4 40999.0 41069.4 29712.3 30137.5 30174.5 30550.7 31202.7 30092.2 30174.1 30591.3 30681.4 31645.1 34172.5 34281.5 34310.0 34331.7 34514.0 29377.3 29534.7 29651.1 29681.3 30119.4 22524.7 22639.5 22906.3 23082.8 23264.2 06:16:17 INFO - PID 4014 | 06:16:17 INFO - PID 4014 | [#2] jquery.html Cycles:180 Average:34907.72 Median:23072.10 stddev:83212.70 (360.7%) stddev-sans-first:83406.14 06:16:17 INFO - PID 4014 | Values: 547.3 551.2 560.0 566.4 581.8 21693.0 22510.4 22536.9 22589.2 22662.9 24900.0 25428.9 25500.4 25524.0 25580.7 6350.3 6468.4 6468.6 6525.1 6533.3 5922.0 6196.4 6323.0 6425.9 6453.2 6376.1 6384.9 6388.8 6393.2 6393.3 6369.5 6374.4 6405.8 6415.7 6417.6 5906.7 5908.9 5941.3 5944.9 5957.2 28161.0 28527.9 28631.3 28909.0 29276.0 2016.6 2054.5 2055.8 2058.8 2060.2 18129.6 18963.2 19035.1 19107.9 19134.4 2311.0 2372.2 2372.7 2374.9 2461.2 133823.0 136379.0 136726.0 136753.0 136773.0 14041.8 14850.5 14873.2 14913.6 15241.6 23030.3 23037.4 23049.2 23095.0 23102.4 9844.3 9915.4 10066.5 10089.1 10146.1 9105.8 9106.1 9110.5 9168.7 9238.2 7709.0 9059.8 9109.6 9155.0 9169.4 2703.7 2755.3 2755.9 2756.5 2861.7 928.4 941.4 960.5 975.4 976.7 19224.7 19290.8 19324.0 19423.6 19731.2 1004.7 1005.0 1031.4 1032.1 1038.3 10548.9 10846.0 10893.5 10919.2 10949.3 482302.0 488577.0 496730.0 500659.0 502429.0 111875.0 117022.4 118465.0 120380.0 120565.4 1162.1 1163.7 1213.6 1215.3 1220.4 20410.6 20528.4 20696.6 20717.2 21944.2 56685.7 57411.0 57600.0 59356.7 60149.7 69570.3 69899.7 70253.3 70828.3 71502.0 13976.4 14465.1 14468.3 14605.9 14784.0 23683.3 23686.8 23686.8 23793.2 23981.0 18157.8 18334.8 18582.2 18597.2 18612.1 16019.7 16346.3 16632.9 17106.4 17676.4 18736.9 18982.8 19032.9 19127.0 19134.3 14164.2 14296.3 14307.6 14335.8 14358.4 18478.4 18495.5 18642.9 18988.5 19026.2 06:16:17 INFO - PID 4014 | 06:16:17 INFO - PID 4014 | [#3] mootools.html Cycles:180 Average:9214.01 Median:2494.33 stddev:6485.49 (260.0%) stddev-sans-first:6476.18 06:16:17 INFO - PID 4014 | Values: 1264.7 1332.6 1333.4 1334.6 1338.7 14588.6 15709.0 15718.4 15745.7 15783.1 15413.7 15668.9 15671.0 15705.9 15711.5 2572.3 2609.9 2610.3 2613.9 2615.9 2487.5 2549.1 2585.1 2592.4 2593.2 2528.9 2729.7 2744.7 2745.1 2745.6 2562.7 2586.6 2686.9 2742.0 2761.2 2467.9 2491.5 2494.2 2494.5 2499.9 14422.2 14445.9 14559.5 14577.4 14600.2 7528.8 7770.9 7787.4 7791.9 7801.0 5116.4 5184.1 5293.7 5367.4 5385.8 1644.9 1705.1 1808.1 1815.4 1850.1 23333.8 23378.1 24642.9 25197.9 25212.0 6339.5 6349.2 6371.7 6512.9 6530.4 16754.7 16793.0 16795.9 16805.7 16820.3 7386.3 7564.4 7567.4 7575.8 7589.5 6889.4 6984.4 7042.5 7066.2 7105.1 4965.5 5109.4 5124.1 5132.5 5149.2 1429.0 1454.8 1502.2 1512.4 1518.7 852.2 860.3 873.3 874.9 881.4 7898.0 7933.1 8096.7 8109.5 8139.6 955.7 982.6 993.7 996.2 1002.9 5223.8 5459.5 5460.6 5526.8 5591.6 20622.5 21626.4 21627.7 21664.8 21696.0 20163.9 20987.9 21007.8 21058.5 21454.4 10712.5 10986.2 11069.7 11075.6 11086.9 8494.4 8857.6 9011.4 9083.4 9135.6 17772.6 18363.3 18388.5 18642.0 18763.8 18245.3 18984.6 19136.1 19159.6 19220.0 11753.4 12186.5 12197.5 12200.6 12205.0 13243.2 13596.3 13604.9 13662.5 13700.3 9623.4 11311.3 11423.4 11463.0 11637.9 10926.7 10940.3 10978.3 11124.2 11251.5 9959.4 10091.0 10110.9 10113.6 10116.1 7350.3 7451.7 7453.4 7631.4 7673.5 7790.0 7793.3 7850.5 7939.2 7962.4 06:16:17 INFO - PID 4014 | 06:16:17 INFO - PID 4014 | [#4] prototype.html Cycles:180 Average:5564.80 Median:6223.03 stddev:1572.82 (25.3%) stddev-sans-first:1530.61 06:16:17 INFO - PID 4014 | Values: 500.8 501.9 513.9 521.6 527.0 6226.5 6288.3 6297.5 6300.7 6364.6 5941.4 6104.4 6162.2 6173.8 6198.9 4946.9 4987.4 5006.7 5014.9 5023.8 4948.5 5032.2 5033.8 5059.9 5074.2 5008.9 5009.6 5011.8 5028.9 5055.5 4997.5 5008.4 5016.3 5025.1 5040.1 4504.8 4521.8 4521.9 4531.9 4543.5 6219.6 6234.8 6262.7 6276.0 6288.2 5666.2 5682.9 5695.2 5784.2 5784.5 6482.6 6609.4 6622.5 6623.6 6645.6 4879.4 4879.6 4889.6 4890.1 4910.0 6884.8 6925.5 6969.9 7023.0 7024.7 5010.9 5026.9 5027.2 5028.7 5032.8 5115.8 5132.7 5135.9 5140.2 5150.5 5691.0 5736.7 5741.1 5743.3 5751.4 6498.3 6499.4 6547.1 6564.3 6579.7 1635.9 1647.9 1679.9 1687.0 1746.4 1202.4 1225.1 1226.9 1228.6 1241.1 5858.3 5866.4 5866.5 5882.8 5885.8 6663.5 6739.9 6825.0 6862.0 6882.6 5873.9 5889.2 5894.5 5894.9 5917.4 3583.4 3612.0 3616.6 3638.5 3643.6 6652.6 6661.0 6677.6 6684.6 6701.2 6993.5 7000.3 7002.4 7005.7 7027.8 6634.2 6647.1 6666.1 6722.7 6724.6 6869.9 6892.4 6899.9 6904.8 6917.2 6768.8 6793.2 6809.8 6817.0 6843.0 6536.2 6635.0 6650.1 6684.2 6702.8 4961.0 4985.2 4999.0 5009.2 5028.0 6531.7 6594.8 6646.5 6719.9 6740.2 6233.7 6358.4 6417.2 6458.9 6541.5 6510.3 6532.8 6547.8 6565.8 6602.4 6368.7 6412.3 6429.9 6455.6 6540.4 6618.3 6655.9 6661.9 6689.5 6710.5 6429.2 6435.4 6447.4 6473.3 6520.6 06:16:17 INFO - PID 4014 | 06:16:17 INFO - PID 4014 | [#5] yui.html Cycles:180 Average:23783.90 Median:20687.53 stddev:32543.90 (157.3%) stddev-sans-first:32589.72 06:16:17 INFO - PID 4014 | Values: 872.2 881.2 894.7 897.2 908.0 16058.8 16554.9 16571.3 16745.3 17149.5 15849.5 16258.7 16829.2 20571.4 20739.4 926.1 945.0 946.1 946.3 949.1 870.3 948.5 949.2 950.9 952.8 1002.8 1009.8 1011.6 1012.4 1012.5 996.4 1000.1 1005.2 1005.6 1005.8 723.9 729.7 734.9 737.8 738.2 17671.7 18460.2 18831.5 19246.6 19254.5 20177.8 20232.8 20669.3 20705.8 21051.7 16172.8 16229.4 16340.8 16428.5 16447.5 3684.3 3732.6 3751.6 3752.6 3754.8 123780.0 125090.0 125668.0 127813.4 128121.0 12443.5 12452.4 12589.2 12599.7 12677.5 29372.3 29941.4 30022.4 30032.4 30087.1 8319.3 8350.3 8662.9 8762.9 8824.3 3917.3 3987.9 3990.6 3991.4 4013.1 4650.3 5578.0 5664.1 5762.5 5765.5 1068.2 1077.3 1103.5 1106.4 1110.3 692.4 700.9 706.3 712.1 715.8 11378.9 11842.2 12019.2 13049.9 13146.1 678.5 680.0 690.7 694.5 698.1 5725.3 5751.3 5814.2 5830.9 5868.0 109347.0 111685.0 111779.0 113315.0 114825.0 92372.5 93213.0 93797.5 95567.0 96286.0 79291.6 91522.0 92104.5 92450.5 94178.0 12624.7 12806.0 12937.2 12964.5 12997.3 40872.2 42165.8 42304.4 42596.8 43053.4 72197.3 73384.0 74869.3 75236.0 77782.0 17580.2 17973.1 18124.5 18351.8 18360.0 21405.1 21468.4 21537.8 21609.9 21687.7 18288.0 18573.9 18664.9 19228.0 19322.7 17131.2 17174.2 19699.4 19938.8 20103.6 18607.2 18669.4 19575.4 19922.5 20108.1 12429.6 12571.3 12880.2 12985.1 13207.3 13860.5 13905.4 13970.2 14070.9 14309.8 06:16:17 INFO - PID 4014 | -------- Summary: end -------- 06:16:17 INFO - PID 4014 | 06:16:18 INFO - TEST-INFO | 4014: exit 0 06:16:18 INFO - TEST-OK | dromaeo_css | took 1111558ms 06:16:18 INFO - TEST-START | kraken 06:16:18 INFO - Initialising browser for kraken test... 06:16:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60861/getInfo.html -profile /tmp/tmpSq3Wrf/profile 06:16:18 INFO - TEST-INFO | started process 4434 (/builds/slave/test/build/application/firefox/firefox http://localhost:60861/getInfo.html) 06:16:23 INFO - TEST-INFO | 4434: exit 0 06:16:23 INFO - Browser initialized. 06:16:23 INFO - Running cycle 1/1 for kraken test... 06:16:23 INFO - TEST-INFO | started process 4620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSq3Wrf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:24 INFO - PID 4620 | 06:16:24 INFO - PID 4620 | (/builds/slave/test/build/application/firefox/firefox:4669): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:16:24 INFO - PID 4620 | 06:16:25 INFO - PID 4620 | 06:16:25 INFO - PID 4620 | (/builds/slave/test/build/application/firefox/firefox:4727): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:16:25 INFO - PID 4620 | 06:16:25 INFO - PID 4620 | __metrics Screen width/height:1600/1200 06:16:25 INFO - PID 4620 | colorDepth:24 06:16:25 INFO - PID 4620 | Browser inner width/height: 1024/768 06:16:25 INFO - PID 4620 | __metrics 06:16:35 INFO - PID 4620 | RSS: Main: 174702592 06:16:35 INFO - PID 4620 | 06:16:37 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60861/tests/kraken/driver.html?testName=audio-beat-detection) 06:16:38 INFO - PID 4620 | RSS: Main: 179650560 06:16:38 INFO - PID 4620 | 06:16:41 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60861/tests/kraken/driver.html?testName=audio-dft) 06:16:42 INFO - PID 4620 | RSS: Main: 181186560 06:16:42 INFO - PID 4620 | 06:16:45 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60861/tests/kraken/driver.html?testName=audio-fft) 06:16:45 INFO - PID 4620 | RSS: Main: 174669824 06:16:45 INFO - PID 4620 | 06:16:47 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60861/tests/kraken/driver.html?testName=audio-oscillator) 06:16:48 INFO - PID 4620 | RSS: Main: 175026176 06:16:48 INFO - PID 4620 | 06:16:50 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60861/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:16:51 INFO - PID 4620 | RSS: Main: 175489024 06:16:51 INFO - PID 4620 | 06:16:54 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60861/tests/kraken/driver.html?testName=imaging-darkroom) 06:16:55 INFO - PID 4620 | RSS: Main: 176615424 06:16:55 INFO - PID 4620 | 06:16:58 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60861/tests/kraken/driver.html?testName=imaging-desaturate) 06:16:59 INFO - PID 4620 | RSS: Main: 176488448 06:16:59 INFO - PID 4620 | 06:17:02 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60861/tests/kraken/driver.html?testName=json-parse-financial) 06:17:02 INFO - PID 4620 | RSS: Main: 177135616 06:17:02 INFO - PID 4620 | 06:17:04 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60861/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:17:05 INFO - PID 4620 | RSS: Main: 177221632 06:17:05 INFO - PID 4620 | 06:17:07 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60861/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:17:07 INFO - PID 4620 | RSS: Main: 177696768 06:17:07 INFO - PID 4620 | 06:17:09 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60861/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:17:10 INFO - PID 4620 | RSS: Main: 177315840 06:17:10 INFO - PID 4620 | 06:17:13 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60861/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:17:13 INFO - PID 4620 | RSS: Main: 177889280 06:17:13 INFO - PID 4620 | 06:17:16 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60861/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:17:17 INFO - PID 4620 | RSS: Main: 177909760 06:17:17 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | Cycle 1(1): loaded http://localhost:60861/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60861/tests/kraken/driver.html?testName=ai-astar) 06:17:19 INFO - PID 4620 | RSS: Main: 179326976 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | __start_tp_report 06:17:19 INFO - PID 4620 | _x_x_mozilla_page_load 06:17:19 INFO - PID 4620 | _x_x_mozilla_page_load_details 06:17:19 INFO - PID 4620 | |i|pagename|runs| 06:17:19 INFO - PID 4620 | |0;ai-astar;105;113;102;108;108;112;110;98;106;107 06:17:19 INFO - PID 4620 | |1;audio-beat-detection;143;117;145;172;117;146;149;119;172;126 06:17:19 INFO - PID 4620 | |2;audio-dft;162;164;164;162;164;160;164;169;162;163 06:17:19 INFO - PID 4620 | |3;audio-fft;76;74;74;172;74;74;78;79;165;80 06:17:19 INFO - PID 4620 | |4;audio-oscillator;79;82;135;80;80;79;130;80;78;127 06:17:19 INFO - PID 4620 | |5;imaging-gaussian-blur;114;114;118;115;115;114;114;114;119;115 06:17:19 INFO - PID 4620 | |6;imaging-darkroom;148;151;149;147;150;149;147;148;149;148 06:17:19 INFO - PID 4620 | |7;imaging-desaturate;94;94;93;94;96;93;93;93;95;93 06:17:19 INFO - PID 4620 | |8;json-parse-financial;54;59;53;53;54;52;54;54;53;54 06:17:19 INFO - PID 4620 | |9;json-stringify-tinderbox;54;54;60;59;55;55;60;59;59;59 06:17:19 INFO - PID 4620 | |10;stanford-crypto-aes;86;75;80;89;74;80;75;82;78;75 06:17:19 INFO - PID 4620 | |11;stanford-crypto-ccm;119;125;125;128;118;117;119;116;128;164 06:17:19 INFO - PID 4620 | |12;stanford-crypto-pbkdf2;169;169;185;174;172;170;170;172;178;169 06:17:19 INFO - PID 4620 | |13;stanford-crypto-sha256-iterative;69;68;66;69;64;68;66;63;62;63 06:17:19 INFO - PID 4620 | __end_tp_report 06:17:19 INFO - PID 4620 | __start_cc_report 06:17:19 INFO - PID 4620 | _x_x_mozilla_cycle_collect,971 06:17:19 INFO - PID 4620 | __end_cc_report 06:17:19 INFO - PID 4620 | __startTimestamp1503580639640__endTimestamp 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | ------- Summary: start ------- 06:17:19 INFO - PID 4620 | Number of tests: 14 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#0] ai-astar Cycles:10 Average:106.90 Median:109.00 stddev:4.51 (4.1%) stddev-sans-first:4.73 06:17:19 INFO - PID 4620 | Values: 105.0 113.0 102.0 108.0 108.0 112.0 110.0 98.0 106.0 107.0 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:145.50 stddev:20.79 (14.3%) stddev-sans-first:22.03 06:17:19 INFO - PID 4620 | Values: 143.0 117.0 145.0 172.0 117.0 146.0 149.0 119.0 172.0 126.0 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#2] audio-dft Cycles:10 Average:163.40 Median:164.00 stddev:2.37 (1.4%) stddev-sans-first:2.46 06:17:19 INFO - PID 4620 | Values: 162.0 164.0 164.0 162.0 164.0 160.0 164.0 169.0 162.0 163.0 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#3] audio-fft Cycles:10 Average:94.60 Median:75.00 stddev:39.05 (52.1%) stddev-sans-first:40.83 06:17:19 INFO - PID 4620 | Values: 76.0 74.0 74.0 172.0 74.0 74.0 78.0 79.0 165.0 80.0 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:79.50 stddev:24.71 (31.1%) stddev-sans-first:25.52 06:17:19 INFO - PID 4620 | Values: 79.0 82.0 135.0 80.0 80.0 79.0 130.0 80.0 78.0 127.0 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:115.00 stddev:1.81 (1.6%) stddev-sans-first:1.87 06:17:19 INFO - PID 4620 | Values: 114.0 114.0 118.0 115.0 115.0 114.0 114.0 114.0 119.0 115.0 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 06:17:19 INFO - PID 4620 | Values: 148.0 151.0 149.0 147.0 150.0 149.0 147.0 148.0 149.0 148.0 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:1.03 (1.1%) stddev-sans-first:1.09 06:17:19 INFO - PID 4620 | Values: 94.0 94.0 93.0 94.0 96.0 93.0 93.0 93.0 95.0 93.0 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.89 (3.5%) stddev-sans-first:2.00 06:17:19 INFO - PID 4620 | Values: 54.0 59.0 53.0 53.0 54.0 52.0 54.0 54.0 53.0 54.0 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#9] json-stringify-tinderbox Cycles:10 Average:57.40 Median:59.00 stddev:2.55 (4.3%) stddev-sans-first:2.39 06:17:19 INFO - PID 4620 | Values: 54.0 54.0 60.0 59.0 55.0 55.0 60.0 59.0 59.0 59.0 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:80.00 stddev:5.08 (6.4%) stddev-sans-first:4.80 06:17:19 INFO - PID 4620 | Values: 86.0 75.0 80.0 89.0 74.0 80.0 75.0 82.0 78.0 75.0 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:125.00 stddev:14.13 (11.3%) stddev-sans-first:14.76 06:17:19 INFO - PID 4620 | Values: 119.0 125.0 125.0 128.0 118.0 117.0 119.0 116.0 128.0 164.0 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:172.00 stddev:5.14 (3.0%) stddev-sans-first:5.26 06:17:19 INFO - PID 4620 | Values: 169.0 169.0 185.0 174.0 172.0 170.0 170.0 172.0 178.0 169.0 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:67.00 stddev:2.66 (4.0%) stddev-sans-first:2.55 06:17:19 INFO - PID 4620 | Values: 69.0 68.0 66.0 69.0 64.0 68.0 66.0 63.0 62.0 63.0 06:17:19 INFO - PID 4620 | -------- Summary: end -------- 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | 06:17:19 INFO - PID 4620 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 06:17:19 INFO - PID 4620 | 06:17:20 INFO - PID 4620 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:17:20 INFO - TEST-INFO | 4620: exit 0 06:17:20 INFO - TEST-OK | kraken | took 62114ms 06:17:20 INFO - SUITE-END | took 1173s 06:17:20 INFO - Completed test suite (00:19:34) 06:17:20 INFO - javascript benchmark 06:17:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8447.324290867004, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3273.9999999999986, 3281.5077738339246, 3304.15743985284, 3320.950185747214, 3321.2361156933903, 6081.3918608139165, 6121.051237058252, 6151.077338399243, 6187.226596675416, 6246.250449946007, 6099.054646529795, 6143.078538219258, 6166.907496387546, 6200.3179650238435, 6200.596961197531, 5686.9146962795485, 5712.22884910538, 5803.970980145094, 5805.709714514279, 5818.040023396155, 5644.7459864306, 5755.165501002352, 5785.739641716133, 5857.472827445529, 5860.589758716891, 5675.574331925101, 5713.457221563945, 5775.075987841946, 5810.767569297223, 5843.561732870031, 5641.548676105943, 5654.264945557093, 5708.800191993302, 5757.884842303172, 5783.2192653992015, 5707.486326230618, 5709.314882214161, 5714.828555143353, 5715.142728590703, 5717.771289148429, 6095.268567771852, 6149.169862068608, 6198.194234749454, 6211.285702144266, 6214.5649804513705, 6453.612783233021, 6597.0, 6683.0977817994435, 6730.899036514456, 6740.427063699592, 6470.57941233823, 6589.374009469093, 6709.630970296632, 6710.966445167792, 6715.294894036154, 6223.844403889849, 6279.717412716439, 6306.306306306303, 6306.716197771066, 6320.0, 6787.490938179656, 6859.794206173823, 6937.965310173417, 6979.8604027919155, 6992.510524263253, 6298.401651843067, 6414.807555773335, 6594.835129121714, 6668.199816022011, 6674.23246326669, 6627.1716035495565, 6663.20041595002, 6712.228093769279, 6714.261431242559, 6721.361470660279, 6600.207975043026, 6601.504887133484, 6647.700853461509, 6667.999800029937, 6687.431568316651, 6531.608103513804, 6625.0724898514245, 6633.170853643294, 6634.800955971328, 6636.203655561363, 5188.688678679291, 5191.974040129775, 5196.272521846944, 5212.478752124757, 5335.359756829128, 4641.025384669189, 4673.719576825333, 4676.298555216745, 4689.1559519286175, 4693.95306046942, 5824.3302020267365, 5834.912476312858, 5900.704964751745, 5905.498032667271, 5920.644761314335, 6579.703913323912, 6671.0, 6684.064231007663, 6686.7993960181275, 6690.732370705215, 5772.134179872969, 5775.624584402084, 5789.768409263583, 5795.159701843209, 5797.8550536236935, 5593.916091258634, 5629.380768115504, 5650.7174641267775, 5658.264425624642, 5674.404187560329, 5998.640081595118, 6430.131932189188, 6473.255575608771, 6592.736290548324, 6599.307072757291, 6674.2658307586125, 6706.966465167643, 6718.160229971254, 6791.320867913169, 6792.626405547742, 6401.423871851555, 6504.772332968323, 6516.51126165549, 6578.703958321983, 6596.67016649156, 6417.839554011187, 6439.645819479973, 6440.452561532322, 6442.323556026738, 6456.644884531396, 6534.607923524603, 6549.508786840911, 6554.967225163844, 6590.143281373391, 6596.0, 6154.476869466145, 6341.334159913143, 6371.840703982438, 6493.675316234075, 6548.3124271952665, 6425.710843012169, 6494.967525162344, 6540.50946179029, 6575.704093315908, 6590.637514936724, 6380.361963803768, 6405.807825765234, 6408.775692850728, 6452.645104519296, 6490.967545162244, 6561.048647946117, 6567.44176744982, 6569.770058047945, 6585.6377899216, 6593.175853018372, 6285.685715714288, 6372.713227904663, 6378.3621637837705, 6383.457406120346, 6392.712327945161], "value": 6080.566252452081, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.6773456750014, 838.1283465196195, 866.0906048648919, 868.1015149320451, 1107.8393632923232, 29317.2670683233, 29893.0, 38338.0, 38863.61136388635, 38922.61077389225, 39675.40486892699, 40000.599994000055, 40021.39967900484, 40023.79988100055, 40056.59943400565, 7256.927430725678, 7571.053618297727, 7720.382369410434, 7736.458447908649, 7851.685932562691, 7675.616219189046, 7747.806304842367, 7754.0, 7758.379329653642, 7789.454738168331, 7722.459427840054, 7770.650320735581, 7815.6482958267015, 7817.2964433201005, 7819.335356494705, 7726.575038372887, 7780.727674531364, 7786.182450842665, 7787.3770098392, 7788.961055194716, 7623.618819059025, 7684.423668224906, 7690.2694244046725, 7693.346065584432, 7706.190849960785, 35760.64239357625, 35944.0, 35949.46075808839, 35962.82018589917, 36023.63976360229, 3452.9309413811584, 3468.8959331220103, 3476.721862251014, 3482.564679415073, 3484.5121682964404, 30201.546976795365, 30257.848710756527, 30366.84816575925, 30562.54156187659, 30595.38809223803, 5097.8215762448135, 5105.336306280197, 5114.718690472023, 5122.564582010534, 5155.510226528511, 179481.0, 180688.0, 180815.0, 181006.0, 181098.09450952793, 45721.31418028732, 45789.084218315445, 45830.31254531185, 45858.312125318145, 45860.08279834384, 47436.288455673195, 47533.0, 47579.0, 47599.5240047602, 47711.5228847714, 15419.0, 15603.453879114177, 15617.297221625055, 15679.451219207273, 15721.921390393203, 11650.76698466043, 11781.469833857496, 12646.494140234472, 12654.746905061847, 12919.418626161845, 13499.865001350057, 13520.18878867271, 13581.320933953262, 13594.86405135936, 13699.178049316874, 5440.91838622421, 5586.329640443091, 5650.446127315021, 5701.287339082614, 5752.28096487939, 998.7503124218945, 1015.3755440404099, 1030.2479190191202, 1034.9327293725885, 1042.1454407386022, 22177.55644887093, 22597.887010564842, 22867.656985145237, 22894.771052289263, 22933.967971441325, 1103.9448027598748, 1123.2474242257706, 1125.5216532973454, 1129.6272230164027, 1129.8813624569466, 11728.530858765555, 12089.516419343303, 12157.878421215852, 12175.512979480898, 12262.877371226352, 207626.0, 207785.0, 208164.0, 208268.0, 209921.0, 48000.7599961998, 48216.758916205195, 48278.0, 48784.26823597649, 48816.511834881196, 1365.6995460998564, 1448.2324368084933, 1451.4629587052857, 1454.0766613200483, 1457.890658200618, 21775.564488710454, 22011.559768804855, 22383.0, 22456.32631021072, 22592.887035564716, 35953.82023089868, 36076.09809754777, 36109.63890361063, 36111.27777444489, 36118.09704757402, 180272.0, 180563.0, 180717.0964145171, 181055.0, 181743.0, 29548.55677164801, 30061.248468788453, 32628.0, 32691.182720432178, 32723.0, 40737.38893916534, 40914.38628420635, 40984.385234220914, 40999.0, 41069.38395924004, 29712.257193570334, 30137.547936781404, 30174.547381788852, 30550.694493054783, 31202.687973119977, 30092.247693806956, 30174.09477715672, 30591.316168238925, 30681.386372272875, 31645.05064848058, 34172.48741268833, 34281.48577771385, 34310.0, 34331.65668343285, 34514.0, 29377.265568360108, 29534.734990806584, 29651.110466686034, 29681.25796855096, 30119.3976120472, 22524.662130067733, 22639.547209056054, 22906.31281061571, 23082.76917230806, 23264.185753498547], "value": 16529.868165382366, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.3322546493276, 551.1842473139756, 559.9860003499912, 566.3883006353142, 581.8109114537775, 21693.0, 22510.437239069033, 22536.88731556344, 22589.209377671785, 22662.88668556657, 24900.0, 25428.872855635695, 25500.36249093769, 25524.0, 25580.744192558115, 6350.301466838644, 6468.353164683541, 6468.611883286994, 6525.086487891699, 6533.31400202979, 5921.993261145594, 6196.442320191182, 6322.968385158068, 6425.903611445832, 6453.161089058416, 6376.107344971708, 6384.872302553946, 6388.840278993016, 6393.200849893763, 6393.296737358887, 6369.458596019297, 6374.426301632852, 6405.807825765211, 6415.679216039202, 6417.582857114273, 5906.675132867691, 5908.852278693067, 5941.346451890288, 5944.940550594482, 5957.165996760457, 28161.0, 28527.85736071327, 28631.28421789451, 28909.0, 29276.0, 2016.5865997470482, 2054.5171884607253, 2055.7533096028424, 2058.7941205879292, 2060.1965233558926, 18129.637407251783, 18963.24147034117, 19035.14341854606, 19107.90446047761, 19134.42596722087, 2311.0, 2372.240882917467, 2372.6559648850994, 2374.8693821839793, 2461.2247142150163, 133823.0, 136379.0, 136726.0, 136753.0, 136772.999999999, 14041.78937315941, 14850.480233191787, 14873.181974991263, 14913.552593422215, 15241.618959525878, 23030.309090727304, 23037.424064398525, 23049.19327823518, 23095.0, 23102.42243943915, 9844.261680374, 9915.355501892354, 10066.496675166212, 10089.142422893989, 10146.08685218319, 9105.77235569116, 9106.134917182857, 9110.544472776335, 9168.724938251864, 9238.168564829197, 7708.961455192801, 9059.81880362389, 9109.635614575343, 9155.0, 9169.449833010041, 2703.6620422447195, 2755.2973991632407, 2755.917322480329, 2756.54517004696, 2861.6852146263896, 928.3872644054892, 941.430434587065, 960.4669408478362, 975.4293738163254, 976.7167521418709, 19224.71162932557, 19290.807091929182, 19324.0, 19423.611527769648, 19731.210751569775, 1004.7287232447198, 1004.9648262310784, 1031.4224034540682, 1032.0866033560203, 1038.3199004651965, 10548.894511054945, 10846.023857852831, 10893.509792059376, 10919.235653504178, 10949.343039417661, 482302.0, 488577.0, 496730.0, 500659.0, 502429.0, 111875.0, 117022.41488792501, 118465.0, 120380.0, 120565.39717301357, 1162.1400163878668, 1163.662537864027, 1213.5691829400612, 1215.3012018089457, 1220.4263995921901, 20410.59178816445, 20528.38414847557, 20696.586068278248, 20717.171313147304, 21944.231951881608, 56685.71657141688, 57411.0, 57600.0, 59356.703216485366, 60149.699251503465, 69570.30429695638, 69899.65050174716, 70253.29746702671, 70828.29171708217, 71502.0, 13976.440942362191, 14465.059771114844, 14468.27658617086, 14605.85394146045, 14784.0, 23683.289501314986, 23686.763132369146, 23686.763132369146, 23793.167239146547, 23981.0, 18157.819741716747, 18334.81665183331, 18582.163802629184, 18597.163127659016, 18612.06939653039, 16019.679606408039, 16346.346146154021, 16632.91683541623, 17106.401275955282, 17676.381326653507, 18736.906315468335, 18982.810171898105, 19032.904835475732, 19127.04364781783, 19134.330298439487, 14164.220967846868, 14296.285185740879, 14307.57077287683, 14335.78496322577, 14358.425662973781, 18478.353257635918, 18495.53761155982, 18642.906785465984, 18988.525286867385, 19026.238950441828], "value": 11927.88517701873, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.6775072356547, 1332.5669157523807, 1333.4266265505828, 1334.6263046347026, 1338.7121768819704, 14588.635284117903, 15709.0, 15718.37126514941, 15745.685086298266, 15783.053016818998, 15413.691726165498, 15668.921655391707, 15671.0, 15705.921470392632, 15711.528654140395, 2572.2926195296304, 2609.9347516312055, 2610.2952202905203, 2613.882375293107, 2615.947681046378, 2487.5273697997413, 2549.1332946798084, 2585.108137692493, 2592.377829320959, 2593.222033389985, 2528.9241322760254, 2729.672439307286, 2744.656917885264, 2745.135282386042, 2745.629340039099, 2562.6796650418696, 2586.5990771430456, 2686.865656717166, 2741.972580274202, 2761.1716485054503, 2467.9136230232034, 2491.5141547398266, 2494.1769216158805, 2494.4761600064007, 2499.8625075620835, 14422.206778627171, 14445.855541444662, 14559.49041783543, 14577.416903323854, 14600.196989165592, 7528.849423011564, 7770.883436748397, 7787.3770098392, 7791.883121753178, 7800.960995195044, 5116.360454943132, 5184.144616138333, 5293.708846013467, 5367.355917289911, 5385.838424847261, 1644.8930819496813, 1705.0792572011098, 1808.0688445450603, 1815.4462888818905, 1850.1396850464598, 23333.766662333328, 23378.064877404882, 24642.876785616136, 25197.874010630014, 25212.0, 6339.461145802658, 6349.174607301022, 6371.745130194833, 6512.869742605216, 6530.379613936669, 16754.74867876983, 16793.0, 16795.91602041982, 16805.747913781302, 16820.327186912386, 7386.2613738625705, 7564.394848412114, 7567.432442566829, 7575.848483030309, 7589.544627322378, 6889.414399776075, 6984.4412447004115, 7042.507024508235, 7066.187388450291, 7105.147382314052, 4965.45380008206, 5109.4379618241965, 5124.12889808726, 5132.486751324837, 5149.2276158576515, 1428.9642758931109, 1454.8326942401548, 1502.1662977047843, 1512.3874830693587, 1518.7494063479623, 852.2074470742145, 860.3332417376583, 873.2969959182792, 874.873143394217, 881.4402854187637, 7898.0, 7933.127355990837, 8096.676132954616, 8109.513429194267, 8139.593020349077, 955.6559638530124, 982.5529384130203, 993.6770549571273, 996.1582462818907, 1002.9398236105711, 5223.764930578057, 5459.454054594509, 5460.645058071213, 5526.834194974077, 5591.608587398924, 20622.484437889172, 21626.35120946374, 21627.67558486624, 21664.783352166593, 21696.0, 20163.871399397758, 20987.8950605246, 21007.78992210089, 21058.47353816136, 21454.425468943828, 10712.464376781285, 10986.230963832455, 11069.667909962553, 11075.612353567747, 11086.889131108746, 8494.405391622528, 8857.601407936787, 9011.369204155908, 9083.36416450842, 9135.63457461694, 17772.644547109245, 18363.265469381076, 18388.54028649241, 18642.0, 18763.812361876207, 18245.270189192284, 18984.620307594047, 19136.13887375099, 19159.616807664046, 19220.0, 11753.353565553634, 12186.451609677408, 12197.451114700038, 12200.633980980585, 12205.0, 13243.20540767557, 13596.320183990563, 13604.863951360756, 13662.521811736542, 13700.314984250947, 9623.422594644344, 11311.264767790068, 11423.428828558704, 11463.0, 11637.941810290895, 10926.726831829268, 10940.343579385262, 10978.341299522055, 11124.165687573302, 11251.549938002716, 9959.352642078242, 10091.0, 10110.949445253022, 10113.64602238918, 10116.1401280889, 7350.338469537767, 7451.701931922879, 7453.366463850633, 7631.427642926692, 7673.501222420525, 7789.961050194713, 7793.2596403341595, 7850.489718168529, 7939.206079392246, 7962.363010958993], "value": 6582.8278347787455, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.7571327905966, 501.8658477806101, 513.8586888605631, 521.6296429535031, 526.9815556455525, 6226.489556742282, 6288.276848162463, 6297.496200303976, 6300.716467758951, 6364.618122912617, 5941.43556362146, 6104.35904230055, 6162.198914141155, 6173.753049878011, 6198.907016394746, 4946.869364080988, 4987.376577927759, 5006.749662516878, 5014.899702005958, 5023.799048038074, 4948.5298896604945, 5032.194848824189, 5033.84898453047, 5059.873503162414, 5074.162763144095, 5008.874778130539, 5009.599232061426, 5011.84964451067, 5028.899422011557, 5055.46917573655, 4997.525235102659, 5008.449070602231, 5016.297718319438, 5025.14572522672, 5040.1179793535985, 4504.842330518449, 4521.773911304422, 4521.909561808746, 4531.864044078683, 4543.5002149763495, 6219.564630475868, 6234.812955611339, 6262.749490020439, 6276.0, 6288.213973253343, 5666.235058267122, 5682.943170568283, 5695.231143795576, 5784.1902133701315, 5784.479396854304, 6482.573833756566, 6609.372109649576, 6622.470202383798, 6623.569467984566, 6645.6344901030425, 4879.414470263591, 4879.609631229493, 4889.633277504201, 4890.117304837628, 4909.975450122763, 6884.827879303058, 6925.480588955848, 6969.863561397391, 7022.964885175593, 7024.683889224997, 5010.924836127461, 5026.944341688213, 5027.1705168647495, 5028.698278103326, 5032.83588057139, 5115.772214668527, 5132.717700526507, 5135.922961155586, 5140.228965655182, 5150.510701483353, 5690.971545142248, 5736.741846616912, 5741.1388291756575, 5743.3395159557185, 5751.396103409165, 6498.252700939358, 6499.447546958561, 6547.148870646881, 6564.343565643493, 6579.736810527525, 1635.8527732503894, 1647.8629745475585, 1679.8576967662107, 1686.957826054334, 1746.3887639326135, 1202.3807739014414, 1225.1179151011258, 1226.8711785262597, 1228.5761412312916, 1241.1126044877956, 5858.326292476335, 5866.413358664185, 5866.50134738552, 5882.794102206402, 5885.823425297248, 6663.533552651268, 6739.898901516482, 6825.0, 6862.0, 6882.5870447773295, 5873.911891321633, 5889.204957330791, 5894.469497745138, 5894.941050589439, 5917.408259174048, 3583.372909740785, 3612.0, 3616.6021737608844, 3638.508801311789, 3643.599204087548, 6652.600843949379, 6661.0, 6677.632730199885, 6684.565503242274, 6701.195856497252, 6993.510454268254, 7000.299970002959, 7002.424454497799, 7005.684744186524, 7027.824304392431, 6634.237062737847, 6647.069410282467, 6666.066750654815, 6722.697478613474, 6724.596524208563, 6869.900815869637, 6892.448604111559, 6899.931000689929, 6904.792856214322, 6917.23910369869, 6768.830779230559, 6793.150856142982, 6809.761658342132, 6817.0, 6843.0, 6536.248331441755, 6634.966825166036, 6650.135482387453, 6684.16447944007, 6702.765403210864, 4961.0, 4985.177445721561, 4999.0, 5009.1966891918155, 5027.974860125676, 6531.673416329069, 6594.769183078569, 6646.468282537288, 6719.942426196167, 6740.157480314961, 6233.688315584112, 6358.427741503102, 6417.197850268716, 6458.935410646021, 6541.476681865344, 6510.316416776171, 6532.771353002622, 6547.803565893031, 6565.80302590923, 6602.372774586406, 6368.688282093378, 6412.2625898022325, 6429.8714025720155, 6455.644939528371, 6540.37866402691, 6618.338166183536, 6655.866882662222, 6661.866762664817, 6689.531732778853, 6710.530262881747, 6429.22849258092, 6435.388638079375, 6447.387498187664, 6473.255575608865, 6520.608763474207], "value": 5097.051063243339, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [872.2150064941547, 881.2245224202703, 894.7449976756624, 897.1745993685809, 907.9682211122612, 16058.83941160588, 16554.92392994456, 16571.254293556787, 16745.330186792515, 17149.485515434524, 15849.524514264562, 16258.674826503462, 16829.242684079214, 20571.382858514233, 20739.377818665427, 926.1433174313767, 944.9527523623825, 946.1059298962483, 946.3375637054055, 949.0699114867434, 870.2602787630527, 948.4830767231841, 949.1979277510493, 950.9191718703919, 952.757046953026, 1002.8345323021692, 1009.8283291840405, 1011.5599714124379, 1012.4279781923227, 1012.4836333469947, 996.4469719305782, 1000.0849222961054, 1005.1807776661997, 1005.5625802775779, 1005.8038682456961, 723.8914162875558, 729.6935287179398, 734.8640501507239, 737.7934178430048, 738.199054026382, 17671.73492397615, 18460.169292381874, 18831.529211769677, 19246.615067698567, 19254.518637034045, 20177.79822201774, 20232.79767202324, 20669.276575319942, 20705.792942070686, 21051.68422473664, 16172.75740863888, 16229.431969881116, 16340.75488867668, 16428.507144785675, 16447.506574802774, 3684.336819372512, 3732.6267373262726, 3751.643593858579, 3752.587215406303, 3754.8498060077563, 123780.0, 125090.0, 125668.0, 127813.36093319567, 128121.0, 12443.502259909503, 12452.439640216213, 12589.24464532131, 12599.748005039848, 12677.492900283885, 29372.265693357836, 29941.40117197644, 30022.39955200884, 30032.39935201284, 30087.097387078422, 8319.292860106958, 8350.33197344211, 8662.91337086621, 8762.86855697165, 8824.338174636929, 3917.334053210961, 3987.9003024924027, 3990.620891015349, 3991.3613821788954, 4013.1171142348635, 4650.302454631832, 5577.972110139423, 5664.065429204135, 5762.538996880324, 5765.509931655856, 1068.1935138970027, 1077.3051381858656, 1103.5309993252836, 1106.397013627575, 1110.306058713304, 692.3630260160563, 700.8738427083174, 706.251373544045, 712.0529695504966, 715.8425146467769, 11378.886211137948, 11842.230255033395, 12019.158658893793, 13049.934750326378, 13146.079774415699, 678.5487650712221, 679.966001699913, 690.7444245629149, 694.5069001009239, 698.1308271202386, 5725.2843394575675, 5751.281089863767, 5814.244148260699, 5830.883382332329, 5867.970660146757, 109347.0, 111685.0, 111779.0, 113315.0, 114825.0, 92372.53813730889, 93213.0, 93797.5310123445, 95567.0, 96286.0, 79291.60354198307, 91522.0, 92104.53947730352, 92450.53774731084, 94178.0, 12624.684382890502, 12806.0, 12937.223766574036, 12964.481420743065, 12997.285149316878, 40872.18255634811, 42165.78917105395, 42304.365434517895, 42596.78701606472, 43053.3541996864, 72197.27802721906, 73384.0, 74869.25130748622, 75236.0, 77782.0, 17580.208890599697, 17973.101344932962, 18124.45626631203, 18351.816481835012, 18360.0, 21405.143794248677, 21468.35594932092, 21537.784622153576, 21609.891950540146, 21687.674684879425, 18288.0, 18573.90713046426, 18664.906675466536, 19228.0, 19322.710159347902, 17131.229094691018, 17174.22715977759, 19699.40901772949, 19938.800611993694, 20103.59792804165, 18607.162677679265, 18669.43991680252, 19575.412737617895, 19922.50193745168, 20108.09513571922, 12429.564965226175, 12571.308578028296, 12880.162789418659, 12985.091043626855, 13207.273599952096, 13860.514881979485, 13905.37425815861, 13970.231637260049, 14070.859291407365, 14309.785353219502], "value": 9031.954991371811, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 102.0, 108.0, 108.0, 112.0, 110.0, 98.0, 106.0, 107.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 145.0, 172.0, 117.0, 146.0, 149.0, 119.0, 172.0, 126.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 162.0, 164.0, 160.0, 164.0, 169.0, 162.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 172.0, 74.0, 74.0, 78.0, 79.0, 165.0, 80.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 135.0, 80.0, 80.0, 79.0, 130.0, 80.0, 78.0, 127.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 118.0, 115.0, 115.0, 114.0, 114.0, 114.0, 119.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 149.0, 147.0, 150.0, 149.0, 147.0, 148.0, 149.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 96.0, 93.0, 93.0, 93.0, 95.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 53.0, 53.0, 54.0, 52.0, 54.0, 54.0, 53.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 60.0, 59.0, 55.0, 55.0, 60.0, 59.0, 59.0, 59.0], "value": 57.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 75.0, 80.0, 89.0, 74.0, 80.0, 75.0, 82.0, 78.0, 75.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 125.0, 125.0, 128.0, 118.0, 117.0, 119.0, 116.0, 128.0, 164.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 185.0, 174.0, 172.0, 170.0, 170.0, 172.0, 178.0, 169.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 66.0, 69.0, 64.0, 68.0, 66.0, 63.0, 62.0, 63.0], "value": 65.8, "unit": "score"}]}]} 06:17:20 INFO - Return code: 0 06:17:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:17:20 INFO - # TBPL SUCCESS # 06:17:20 INFO - Running post-action listener: _package_coverage_data 06:17:20 INFO - Running post-action listener: _resource_record_post_action 06:17:20 INFO - [mozharness: 2017-08-24 13:17:20.922326Z] Finished run-tests step (success) 06:17:20 INFO - Running post-run listener: _resource_record_post_run 06:17:21 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 430493696; Read time: 0; Write time: 260364 06:17:21 INFO - TinderboxPrint: CPU usage
13.1% 06:17:21 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:17:21 INFO - TinderboxPrint: I/O write bytes / time
430,493,696 / 260,364 06:17:21 INFO - TinderboxPrint: CPU idle
8,255.6 (86.9%) 06:17:21 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 06:17:21 INFO - TinderboxPrint: Swap in / out
0 / 0 06:17:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105558016; Read time: 0; Write time: 55900 06:17:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:17:21 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 324431872; Read time: 0; Write time: 204460 06:17:21 INFO - Running post-run listener: _upload_blobber_files 06:17:21 INFO - Blob upload gear active. 06:17:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:17:21 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 06:17:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:17:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:17:21 INFO - (blobuploader) - INFO - Open directory for files ... 06:17:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:17:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:17:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:28 INFO - (blobuploader) - INFO - Done attempting. 06:17:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:17:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:17:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:29 INFO - (blobuploader) - INFO - Done attempting. 06:17:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:17:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:17:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:30 INFO - (blobuploader) - INFO - Done attempting. 06:17:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:17:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:17:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:32 INFO - (blobuploader) - INFO - Done attempting. 06:17:32 INFO - (blobuploader) - INFO - Iteration through files over. 06:17:32 INFO - Return code: 0 06:17:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:17:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:17:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa8f27388892d7de76e054bd9dee2cf240980f0e658674f780f478ec967aba0c2e38b27e431b772b416928bbb7364f3e37034b504f86e7a65c06b88d286aa5e0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06ddbdd6194178648dd4688c3bf7db3292be8e777977853f93cbf34a09831501a59ca2ff5c80a6571044eccadd83d50b277742ea49bda1ec33cb0972d7f0f211", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a82228a8b6189e22f9fe7ac65cc772d4ef3dc2301b980e4a8a5ef7d1c348b483784f8468a7466a8b53214a6203eba5fa33a1113c1b983c96674b91e979f1653", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1d05c757b9db46d8d1fdf148fd0c4d5fe1513e8ab7e06876f235cf8e607c01b40fca736283e4c103edfc95dca2d388cb61e823cf545417cb665935500f6805a"} 06:17:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:17:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:17:32 INFO - Contents: 06:17:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa8f27388892d7de76e054bd9dee2cf240980f0e658674f780f478ec967aba0c2e38b27e431b772b416928bbb7364f3e37034b504f86e7a65c06b88d286aa5e0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06ddbdd6194178648dd4688c3bf7db3292be8e777977853f93cbf34a09831501a59ca2ff5c80a6571044eccadd83d50b277742ea49bda1ec33cb0972d7f0f211", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a82228a8b6189e22f9fe7ac65cc772d4ef3dc2301b980e4a8a5ef7d1c348b483784f8468a7466a8b53214a6203eba5fa33a1113c1b983c96674b91e979f1653", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1d05c757b9db46d8d1fdf148fd0c4d5fe1513e8ab7e06876f235cf8e607c01b40fca736283e4c103edfc95dca2d388cb61e823cf545417cb665935500f6805a"} 06:17:32 INFO - Running post-run listener: copy_logs_to_upload_dir 06:17:32 INFO - Copying logs to upload dir... 06:17:32 INFO - mkdir: /builds/slave/test/build/upload/logs 06:17:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.460521 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-24 06:17:32.072509) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 06:17:32.077456) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa8f27388892d7de76e054bd9dee2cf240980f0e658674f780f478ec967aba0c2e38b27e431b772b416928bbb7364f3e37034b504f86e7a65c06b88d286aa5e0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06ddbdd6194178648dd4688c3bf7db3292be8e777977853f93cbf34a09831501a59ca2ff5c80a6571044eccadd83d50b277742ea49bda1ec33cb0972d7f0f211", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a82228a8b6189e22f9fe7ac65cc772d4ef3dc2301b980e4a8a5ef7d1c348b483784f8468a7466a8b53214a6203eba5fa33a1113c1b983c96674b91e979f1653", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1d05c757b9db46d8d1fdf148fd0c4d5fe1513e8ab7e06876f235cf8e607c01b40fca736283e4c103edfc95dca2d388cb61e823cf545417cb665935500f6805a"} build_url:https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011361 build_url: 'https://queue.taskcluster.net/v1/task/ZAmByIIwSJKylSbIRUWeYQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa8f27388892d7de76e054bd9dee2cf240980f0e658674f780f478ec967aba0c2e38b27e431b772b416928bbb7364f3e37034b504f86e7a65c06b88d286aa5e0", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06ddbdd6194178648dd4688c3bf7db3292be8e777977853f93cbf34a09831501a59ca2ff5c80a6571044eccadd83d50b277742ea49bda1ec33cb0972d7f0f211", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a82228a8b6189e22f9fe7ac65cc772d4ef3dc2301b980e4a8a5ef7d1c348b483784f8468a7466a8b53214a6203eba5fa33a1113c1b983c96674b91e979f1653", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1d05c757b9db46d8d1fdf148fd0c4d5fe1513e8ab7e06876f235cf8e607c01b40fca736283e4c103edfc95dca2d388cb61e823cf545417cb665935500f6805a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-24 06:17:32.106934) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 06:17:32.107273) ========= 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=23a51e5d4d00092b8466c6c0000001c3-1503579395.700233-881238225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-24 06:17:32.186981) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 06:17:32.190313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-24 06:17:32.190611) ========= ========= Total master_lag: 0.16 =========