builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-070 starttime: 1506366580.12 results: success (0) revision: 33b7b8e81b4befcba503c0e48cd5370aeb715085 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.116146) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.116588) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.116874) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.134203) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.134512) ========= 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=2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-25 12:09:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2017-09-25 12:09:40 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125494 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.276930) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.277259) ========= 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=2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017578 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.329828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.333173) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 33b7b8e81b4befcba503c0e48cd5370aeb715085 --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 33b7b8e81b4befcba503c0e48cd5370aeb715085 --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=2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-25 12:09:40,372 truncating revision to first 12 chars 2017-09-25 12:09:40,372 Setting DEBUG logging. 2017-09-25 12:09:40,372 attempt 1/10 2017-09-25 12:09:40,372 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/33b7b8e81b4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-25 12:09:40,641 unpacking tar archive at: mozilla-central-33b7b8e81b4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554529 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.903595) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.903914) ========= script_repo_revision: 33b7b8e81b4befcba503c0e48cd5370aeb715085 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.904293) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.904560) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-25 12:09:40.922919) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-25 12:09:40.923210) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:09:41 INFO - MultiFileLogger online at 20170925 12:09:41 in /builds/slave/test 12:09:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:09:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:09:41 INFO - {'append_to_log': False, 12:09:41 INFO - 'base_work_dir': '/builds/slave/test', 12:09:41 INFO - 'blob_upload_branch': 'Firefox', 12:09:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:09:41 INFO - 'branch': 'Firefox', 12:09:41 INFO - 'buildbot_json_path': 'buildprops.json', 12:09:41 INFO - 'code_coverage': False, 12:09:41 INFO - 'config_files': ('talos/linux_config.py',), 12:09:41 INFO - 'default_actions': ('clobber', 12:09:41 INFO - 'read-buildbot-config', 12:09:41 INFO - 'download-and-extract', 12:09:41 INFO - 'populate-webroot', 12:09:41 INFO - 'create-virtualenv', 12:09:41 INFO - 'install', 12:09:41 INFO - 'setup-mitmproxy', 12:09:41 INFO - 'run-tests'), 12:09:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:09:41 INFO - 'disable_ccov_upload': False, 12:09:41 INFO - 'disable_stylo': False, 12:09:41 INFO - 'download_minidump_stackwalk': True, 12:09:41 INFO - 'download_symbols': 'ondemand', 12:09:41 INFO - 'enable_stylo': False, 12:09:41 INFO - 'enable_webrender': False, 12:09:41 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:09:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:09:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:09:41 INFO - 'gecko_profile': False, 12:09:41 INFO - 'gecko_profile_interval': 0, 12:09:41 INFO - 'installer_path': 'installer.exe', 12:09:41 INFO - 'log_level': 'info', 12:09:41 INFO - 'log_name': 'talos', 12:09:41 INFO - 'log_to_console': True, 12:09:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:09:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:09:41 INFO - 'opt_config_files': (), 12:09:41 INFO - 'pip_index': False, 12:09:41 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 12:09:41 INFO - 'system_bits': '32', 12:09:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:09:41 INFO - 'title': 'talos-linux64-ix-070', 12:09:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:09:41 INFO - 'use_talos_json': True, 12:09:41 INFO - 'verify': 'False', 12:09:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:09:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:09:41 INFO - 'work_dir': 'build'} 12:09:41 INFO - [mozharness: 2017-09-25 19:09:41.099365Z] Running clobber step. 12:09:41 INFO - Running pre-action listener: _resource_record_pre_action 12:09:41 INFO - Running main action method: clobber 12:09:41 INFO - rmtree: /builds/slave/test/build 12:09:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:09:42 INFO - Running post-action listener: _resource_record_post_action 12:09:42 INFO - [mozharness: 2017-09-25 19:09:42.101520Z] Finished clobber step (success) 12:09:42 INFO - [mozharness: 2017-09-25 19:09:42.101617Z] Running read-buildbot-config step. 12:09:42 INFO - Running pre-action listener: _resource_record_pre_action 12:09:42 INFO - Running main action method: read_buildbot_config 12:09:42 INFO - Using buildbot properties: 12:09:42 INFO - { 12:09:42 INFO - "project": "", 12:09:42 INFO - "product": "firefox", 12:09:42 INFO - "who": "ffxbld@noreply.mozilla.org", 12:09:42 INFO - "installer_path": "public/build/target.tar.bz2", 12:09:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 12:09:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:09:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 12:09:42 INFO - "stage_platform": "linux64-pgo", 12:09:42 INFO - "basedir": "/builds/slave/test", 12:09:42 INFO - "buildnumber": 59, 12:09:42 INFO - "platform": "ubuntu64_hw", 12:09:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:09:42 INFO - "slavebuilddir": "test", 12:09:42 INFO - "taskId": "ERwts70fQg-JAfslk50YEw", 12:09:42 INFO - "branch": "mozilla-central", 12:09:42 INFO - "script_repo_revision": "production", 12:09:42 INFO - "revision": "33b7b8e81b4befcba503c0e48cd5370aeb715085", 12:09:42 INFO - "slavename": "talos-linux64-ix-070", 12:09:42 INFO - "repo_path": "mozilla-central" 12:09:42 INFO - } 12:09:42 INFO - Finding installer, test and symbols from parent task. 12:09:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ERwts70fQg-JAfslk50YEw'}, attempt #1 12:09:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ERwts70fQg-JAfslk50YEw'}, attempt #1 12:09:42 INFO - Task dependencies: NWLEEd7oRfGpMvp2N6mJHQ 12:09:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ'}, attempt #1 12:09:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.tar.bz2 12:09:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.test_packages.json 12:09:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.crashreporter-symbols.zip 12:09:43 INFO - Running post-action listener: _resource_record_post_action 12:09:43 INFO - [mozharness: 2017-09-25 19:09:43.424472Z] Finished read-buildbot-config step (success) 12:09:43 INFO - [mozharness: 2017-09-25 19:09:43.424691Z] Running download-and-extract step. 12:09:43 INFO - Running pre-action listener: _resource_record_pre_action 12:09:43 INFO - Running main action method: download_and_extract 12:09:43 INFO - mkdir: /builds/slave/test/build/tests 12:09:43 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')]} 12:09:43 INFO - trying https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.test_packages.json 12:09:43 INFO - Downloading https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:09:44 INFO - Downloaded 989 bytes. 12:09:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:09:44 INFO - Using the following test package requirements: 12:09:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:09:44 INFO - u'common': [u'target.common.tests.zip'], 12:09:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:09:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:09:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:09:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:09:44 INFO - u'mozbase': [u'target.common.tests.zip'], 12:09:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:09:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:09:44 INFO - u'web-platform': [u'target.common.tests.zip', 12:09:44 INFO - u'target.web-platform.tests.tar.gz'], 12:09:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:09:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:09:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.common.tests.zip 12:09:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:09:44 INFO - Fetch https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.common.tests.zip into memory 12:09:45 INFO - Content-Length response header: 55360545 12:09:45 INFO - Bytes received: 55360545 12:09:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.talos.tests.zip 12:09:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:09:55 INFO - Fetch https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.talos.tests.zip into memory 12:09:56 INFO - Content-Length response header: 14513823 12:09:56 INFO - Bytes received: 14513823 12:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:56 INFO - trying https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.tar.bz2 12:09:56 INFO - Downloading https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:09:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:09:58 INFO - Downloaded 62345657 bytes. 12:09:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.tar.bz2 12:09:58 INFO - mkdir: /builds/slave/test/properties 12:09:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:09:58 INFO - Writing to file /builds/slave/test/properties/build_url 12:09:58 INFO - Contents: 12:09:58 INFO - build_url:https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.tar.bz2 12:09:58 INFO - Running post-action listener: _resource_record_post_action 12:09:58 INFO - Running post-action listener: find_tests_for_verification 12:09:58 INFO - Running post-action listener: set_extra_try_arguments 12:09:58 INFO - [mozharness: 2017-09-25 19:09:58.032199Z] Finished download-and-extract step (success) 12:09:58 INFO - [mozharness: 2017-09-25 19:09:58.032296Z] Running populate-webroot step. 12:09:58 INFO - Running pre-action listener: _resource_record_pre_action 12:09:58 INFO - Running main action method: populate_webroot 12:09:58 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:09:58 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:09:58 INFO - 'tests': ['tresize', 12:09:58 INFO - 'tcanvasmark']}, 12:09:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:09:58 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:09:58 INFO - 'tests': ['dromaeo_css', 12:09:58 INFO - 'kraken']}, 12:09:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:09:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:09:58 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:09:58 INFO - 'talos_options': ['--disable-stylo'], 12:09:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:09:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:09:58 INFO - 'tests': ['damp', 'tps']}, 12:09:58 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:09:58 INFO - 'talos_options': ['--disable-stylo'], 12:09:58 INFO - 'tests': ['damp', 'tps']}, 12:09:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:09:58 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:09:58 INFO - 'tests': ['dromaeo_dom']}, 12:09:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:09:58 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:09:58 INFO - 'tests': ['basic_compositor_video', 12:09:58 INFO - 'glvideo']}, 12:09:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:09:58 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:09:58 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:09:58 INFO - 'talos_options': ['--disable-stylo'], 12:09:58 INFO - 'tests': ['ts_paint_webext', 12:09:58 INFO - 'tp5o_webext']}, 12:09:58 INFO - 'other-e10s': {'tests': ['a11yr', 12:09:58 INFO - 'ts_paint', 12:09:58 INFO - 'tpaint', 12:09:58 INFO - 'sessionrestore', 12:09:58 INFO - 'sessionrestore_many_windows', 12:09:58 INFO - 'sessionrestore_no_auto_restore', 12:09:58 INFO - 'tabpaint']}, 12:09:58 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:09:58 INFO - 'tests': ['a11yr', 12:09:58 INFO - 'ts_paint', 12:09:58 INFO - 'tpaint', 12:09:58 INFO - 'sessionrestore', 12:09:58 INFO - 'sessionrestore_many_windows', 12:09:58 INFO - 'sessionrestore_no_auto_restore', 12:09:58 INFO - 'tabpaint']}, 12:09:58 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 12:09:58 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:09:58 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:09:58 INFO - 'tests': ['perf_reftest_singletons']}, 12:09:58 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:09:58 INFO - 'tests': ['perf_reftest']}, 12:09:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:09:58 INFO - 'tsvgr_opacity', 12:09:58 INFO - 'tart', 12:09:58 INFO - 'tscrollx', 12:09:58 INFO - 'tsvg_static']}, 12:09:58 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:09:58 INFO - 'tests': ['tsvgx', 12:09:58 INFO - 'tsvgr_opacity', 12:09:58 INFO - 'tart', 12:09:58 INFO - 'tscrollx', 12:09:58 INFO - 'tsvg_static']}, 12:09:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:09:58 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:09:58 INFO - 'talos_options': ['--disable-stylo'], 12:09:58 INFO - 'tests': ['tp5o']}, 12:09:58 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:09:58 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:09:58 INFO - 'talos_options': ['--mitmproxy', 12:09:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:09:58 INFO - '--firstNonBlankPaint'], 12:09:58 INFO - 'tests': ['tp6_google', 12:09:58 INFO - 'tp6_youtube', 12:09:58 INFO - 'tp6_amazon', 12:09:58 INFO - 'tp6_facebook']}, 12:09:58 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:09:58 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:09:58 INFO - 'talos_options': ['--disable-stylo', 12:09:58 INFO - '--mitmproxy', 12:09:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:09:58 INFO - '--firstNonBlankPaint'], 12:09:58 INFO - 'tests': ['tp6_google', 12:09:58 INFO - 'tp6_youtube', 12:09:58 INFO - 'tp6_amazon', 12:09:58 INFO - 'tp6_facebook']}, 12:09:58 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:09:58 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:09:58 INFO - 'talos_options': ['--stylo-threads=1', 12:09:58 INFO - '--mitmproxy', 12:09:58 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:09:58 INFO - '--firstNonBlankPaint'], 12:09:58 INFO - 'tests': ['tp6_google', 12:09:58 INFO - 'tp6_youtube', 12:09:58 INFO - 'tp6_amazon', 12:09:58 INFO - 'tp6_facebook']}, 12:09:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:09:58 INFO - 'talos_options': ['--xperf_path', 12:09:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:09:58 INFO - 'tests': ['tp5n']}, 12:09:58 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:09:58 INFO - 'talos_options': ['--disable-stylo', 12:09:58 INFO - '--xperf_path', 12:09:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:09:58 INFO - 'tests': ['tp5n']}}} 12:09:58 INFO - Running post-action listener: _resource_record_post_action 12:09:58 INFO - [mozharness: 2017-09-25 19:09:58.048394Z] Finished populate-webroot step (success) 12:09:58 INFO - [mozharness: 2017-09-25 19:09:58.048502Z] Running create-virtualenv step. 12:09:58 INFO - Running pre-action listener: _resource_record_pre_action 12:09:58 INFO - Running main action method: create_virtualenv 12:09:58 INFO - Creating virtualenv /builds/slave/test/build/venv 12:09:58 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:09:58 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:09:58 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:09:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:09:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:09:58 INFO - Installing distribute.............................................................................................................................................................................................done. 12:09:58 INFO - Installing pip...............done. 12:09:59 INFO - Return code: 0 12:09:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:09:59 INFO - Reading from file tmpfile_stdout 12:09:59 INFO - Output received: 12:09:59 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:09:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1facb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ed60>, '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 0x214fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', '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 12:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:09:59 INFO - Using env: {'DISPLAY': ':0', 12:09:59 INFO - 'HOME': '/home/cltbld', 12:09:59 INFO - 'LANG': 'en_US.UTF-8', 12:09:59 INFO - 'LANGUAGE': 'en_US:en', 12:09:59 INFO - 'LOGNAME': 'cltbld', 12:09:59 INFO - 'MAIL': '/var/mail/cltbld', 12:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:59 INFO - 'MOZ_NO_REMOTE': '1', 12:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:09:59 INFO - 'NO_EM_RESTART': '1', 12:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:59 INFO - 'PWD': '/builds/slave/test', 12:09:59 INFO - 'SHELL': '/bin/bash', 12:09:59 INFO - 'SHLVL': '1', 12:09:59 INFO - 'TERM': 'linux', 12:09:59 INFO - 'TMOUT': '86400', 12:09:59 INFO - 'USER': 'cltbld', 12:09:59 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', 12:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:59 INFO - '_': '/tools/buildbot/bin/python'} 12:10:00 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:10:00 INFO - Downloading/unpacking pip>=1.5 12:10:00 INFO - Running setup.py egg_info for package pip 12:10:00 INFO - warning: no files found matching 'pip/cacert.pem' 12:10:00 INFO - warning: no files found matching '*.html' under directory 'docs' 12:10:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:10:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:10:00 INFO - Installing collected packages: pip 12:10:00 INFO - Found existing installation: pip 1.1 12:10:00 INFO - Uninstalling pip: 12:10:00 INFO - Successfully uninstalled pip 12:10:00 INFO - Running setup.py install for pip 12:10:00 INFO - warning: no files found matching 'pip/cacert.pem' 12:10:00 INFO - warning: no files found matching '*.html' under directory 'docs' 12:10:00 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:10:00 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:10:00 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:10:00 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:10:00 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:10:00 INFO - Successfully installed pip 12:10:00 INFO - Cleaning up... 12:10:00 INFO - Return code: 0 12:10:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1de41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1facb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ed60>, '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 0x214fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', '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 12:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:10:00 INFO - Using env: {'DISPLAY': ':0', 12:10:00 INFO - 'HOME': '/home/cltbld', 12:10:00 INFO - 'LANG': 'en_US.UTF-8', 12:10:00 INFO - 'LANGUAGE': 'en_US:en', 12:10:00 INFO - 'LOGNAME': 'cltbld', 12:10:00 INFO - 'MAIL': '/var/mail/cltbld', 12:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:00 INFO - 'MOZ_NO_REMOTE': '1', 12:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:00 INFO - 'NO_EM_RESTART': '1', 12:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:00 INFO - 'PWD': '/builds/slave/test', 12:10:00 INFO - 'SHELL': '/bin/bash', 12:10:00 INFO - 'SHLVL': '1', 12:10:00 INFO - 'TERM': 'linux', 12:10:00 INFO - 'TMOUT': '86400', 12:10:00 INFO - 'USER': 'cltbld', 12:10:00 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', 12:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:00 INFO - '_': '/tools/buildbot/bin/python'} 12:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:00 INFO - Downloading/unpacking psutil>=3.1.1 12:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:10:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:10:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:10:01 INFO - Installing collected packages: psutil 12:10:01 INFO - Running setup.py install for psutil 12:10:01 INFO - building 'psutil._psutil_linux' extension 12:10:01 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 12:10:01 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 12:10:02 INFO - building 'psutil._psutil_posix' extension 12:10:02 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 12:10:02 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 12:10:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:10:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:10:02 INFO - Successfully installed psutil 12:10:02 INFO - Cleaning up... 12:10:02 INFO - Return code: 0 12:10:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1facb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ed60>, '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 0x214fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', '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 12:10:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:10:02 INFO - Using env: {'DISPLAY': ':0', 12:10:02 INFO - 'HOME': '/home/cltbld', 12:10:02 INFO - 'LANG': 'en_US.UTF-8', 12:10:02 INFO - 'LANGUAGE': 'en_US:en', 12:10:02 INFO - 'LOGNAME': 'cltbld', 12:10:02 INFO - 'MAIL': '/var/mail/cltbld', 12:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:02 INFO - 'MOZ_NO_REMOTE': '1', 12:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:02 INFO - 'NO_EM_RESTART': '1', 12:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:02 INFO - 'PWD': '/builds/slave/test', 12:10:02 INFO - 'SHELL': '/bin/bash', 12:10:02 INFO - 'SHLVL': '1', 12:10:02 INFO - 'TERM': 'linux', 12:10:02 INFO - 'TMOUT': '86400', 12:10:02 INFO - 'USER': 'cltbld', 12:10:02 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', 12:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:02 INFO - '_': '/tools/buildbot/bin/python'} 12:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:10:03 INFO - Installing collected packages: mozsystemmonitor 12:10:03 INFO - Running setup.py install for mozsystemmonitor 12:10:03 INFO - Successfully installed mozsystemmonitor 12:10:03 INFO - Cleaning up... 12:10:04 INFO - Return code: 0 12:10:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1de41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1facb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ed60>, '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 0x214fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', '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 12:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:10:04 INFO - Using env: {'DISPLAY': ':0', 12:10:04 INFO - 'HOME': '/home/cltbld', 12:10:04 INFO - 'LANG': 'en_US.UTF-8', 12:10:04 INFO - 'LANGUAGE': 'en_US:en', 12:10:04 INFO - 'LOGNAME': 'cltbld', 12:10:04 INFO - 'MAIL': '/var/mail/cltbld', 12:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:04 INFO - 'MOZ_NO_REMOTE': '1', 12:10:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:04 INFO - 'NO_EM_RESTART': '1', 12:10:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:04 INFO - 'PWD': '/builds/slave/test', 12:10:04 INFO - 'SHELL': '/bin/bash', 12:10:04 INFO - 'SHLVL': '1', 12:10:04 INFO - 'TERM': 'linux', 12:10:04 INFO - 'TMOUT': '86400', 12:10:04 INFO - 'USER': 'cltbld', 12:10:04 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', 12:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:04 INFO - '_': '/tools/buildbot/bin/python'} 12:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:04 INFO - Downloading/unpacking jsonschema==2.5.1 12:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:10:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:05 INFO - Downloading functools32-3.2.3-2.tar.gz 12:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:10:05 INFO - warning: no files found matching '*.txt' 12:10:05 INFO - no previously-included directories found matching 'build' 12:10:05 INFO - no previously-included directories found matching 'dist' 12:10:05 INFO - no previously-included directories found matching '.git*' 12:10:05 INFO - Installing collected packages: jsonschema, functools32 12:10:06 INFO - Running setup.py install for functools32 12:10:06 INFO - warning: no files found matching '*.txt' 12:10:06 INFO - no previously-included directories found matching 'build' 12:10:06 INFO - no previously-included directories found matching 'dist' 12:10:06 INFO - no previously-included directories found matching '.git*' 12:10:06 INFO - Successfully installed jsonschema functools32 12:10:06 INFO - Cleaning up... 12:10:06 INFO - Return code: 0 12:10:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:06 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 0x1de41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1facb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ed60>, '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 0x214fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', '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 12:10:06 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 12:10:06 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 12:10:06 INFO - Using env: {'DISPLAY': ':0', 12:10:06 INFO - 'HOME': '/home/cltbld', 12:10:06 INFO - 'LANG': 'en_US.UTF-8', 12:10:06 INFO - 'LANGUAGE': 'en_US:en', 12:10:06 INFO - 'LOGNAME': 'cltbld', 12:10:06 INFO - 'MAIL': '/var/mail/cltbld', 12:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:06 INFO - 'MOZ_NO_REMOTE': '1', 12:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:06 INFO - 'NO_EM_RESTART': '1', 12:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:06 INFO - 'PWD': '/builds/slave/test', 12:10:06 INFO - 'SHELL': '/bin/bash', 12:10:06 INFO - 'SHLVL': '1', 12:10:06 INFO - 'TERM': 'linux', 12:10:06 INFO - 'TMOUT': '86400', 12:10:06 INFO - 'USER': 'cltbld', 12:10:06 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', 12:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:06 INFO - '_': '/tools/buildbot/bin/python'} 12:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:10:06 INFO - Cleaning up... 12:10:06 INFO - Return code: 0 12:10:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:06 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 0x1de41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1facb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ed60>, '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 0x214fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', '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 12:10:06 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 12:10:06 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 12:10:06 INFO - Using env: {'DISPLAY': ':0', 12:10:06 INFO - 'HOME': '/home/cltbld', 12:10:06 INFO - 'LANG': 'en_US.UTF-8', 12:10:06 INFO - 'LANGUAGE': 'en_US:en', 12:10:06 INFO - 'LOGNAME': 'cltbld', 12:10:06 INFO - 'MAIL': '/var/mail/cltbld', 12:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:06 INFO - 'MOZ_NO_REMOTE': '1', 12:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:06 INFO - 'NO_EM_RESTART': '1', 12:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:06 INFO - 'PWD': '/builds/slave/test', 12:10:06 INFO - 'SHELL': '/bin/bash', 12:10:06 INFO - 'SHLVL': '1', 12:10:06 INFO - 'TERM': 'linux', 12:10:06 INFO - 'TMOUT': '86400', 12:10:06 INFO - 'USER': 'cltbld', 12:10:06 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', 12:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:06 INFO - '_': '/tools/buildbot/bin/python'} 12:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:07 INFO - Downloading/unpacking blobuploader==1.2.4 12:10:07 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 12:10:07 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 12:10:07 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 12:10:07 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 12:10:08 INFO - Downloading blobuploader-1.2.4.tar.gz 12:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:10:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:10:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:08 INFO - Downloading docopt-0.6.1.tar.gz 12:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:10:08 INFO - Installing collected packages: blobuploader, requests, docopt 12:10:08 INFO - Running setup.py install for blobuploader 12:10:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:10:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:10:08 INFO - Running setup.py install for requests 12:10:09 INFO - Running setup.py install for docopt 12:10:09 INFO - Successfully installed blobuploader requests docopt 12:10:09 INFO - Cleaning up... 12:10:09 INFO - Return code: 0 12:10:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:10:09 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')]} 12:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:09 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')]} 12:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:09 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 0x1de41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1facb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ed60>, '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 0x214fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', '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 12:10:09 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 12:10:09 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 12:10:09 INFO - Using env: {'DISPLAY': ':0', 12:10:09 INFO - 'HOME': '/home/cltbld', 12:10:09 INFO - 'LANG': 'en_US.UTF-8', 12:10:09 INFO - 'LANGUAGE': 'en_US:en', 12:10:09 INFO - 'LOGNAME': 'cltbld', 12:10:09 INFO - 'MAIL': '/var/mail/cltbld', 12:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:09 INFO - 'MOZ_NO_REMOTE': '1', 12:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:09 INFO - 'NO_EM_RESTART': '1', 12:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:09 INFO - 'PWD': '/builds/slave/test', 12:10:09 INFO - 'SHELL': '/bin/bash', 12:10:09 INFO - 'SHLVL': '1', 12:10:09 INFO - 'TERM': 'linux', 12:10:09 INFO - 'TMOUT': '86400', 12:10:09 INFO - 'USER': 'cltbld', 12:10:09 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', 12:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:09 INFO - '_': '/tools/buildbot/bin/python'} 12:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:10:09 INFO - Running setup.py (path:/tmp/pip-r1Jdvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:10:09 INFO - Running setup.py (path:/tmp/pip-lMqtm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:10:09 INFO - Running setup.py (path:/tmp/pip-cDPm78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:10:09 INFO - Running setup.py (path:/tmp/pip-POblcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:10:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:10:09 INFO - Running setup.py (path:/tmp/pip-4MZDPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:10:10 INFO - Running setup.py (path:/tmp/pip-xms1Ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:10:10 INFO - Running setup.py (path:/tmp/pip-DQc9q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:10:10 INFO - Running setup.py (path:/tmp/pip-Rro8k0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:10:10 INFO - Running setup.py (path:/tmp/pip-cq0lIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:10:10 INFO - Running setup.py (path:/tmp/pip-cDpx2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:10:10 INFO - Running setup.py (path:/tmp/pip-rCzE7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:10:10 INFO - Running setup.py (path:/tmp/pip-ctf2hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:10:10 INFO - Running setup.py (path:/tmp/pip-KhO74u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:10:10 INFO - Running setup.py (path:/tmp/pip-T_Xc2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:10 INFO - Running setup.py (path:/tmp/pip-ld70r6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:10:10 INFO - Running setup.py (path:/tmp/pip-lhcYk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:10:10 INFO - Running setup.py (path:/tmp/pip-tSBPaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:10:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:10:10 INFO - Running setup.py install for manifestparser 12:10:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:10:11 INFO - Running setup.py install for mozcrash 12:10:11 INFO - Running setup.py install for mozdebug 12:10:11 INFO - Running setup.py install for mozdevice 12:10:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:10:11 INFO - Running setup.py install for mozfile 12:10:11 INFO - Running setup.py install for mozhttpd 12:10:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:10:11 INFO - Running setup.py install for mozinfo 12:10:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:10:11 INFO - Running setup.py install for mozInstall 12:10:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:10:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:10:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:10:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:10:11 INFO - Running setup.py install for mozleak 12:10:11 INFO - Running setup.py install for mozlog 12:10:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:10:11 INFO - Running setup.py install for moznetwork 12:10:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:10:12 INFO - Running setup.py install for mozprocess 12:10:12 INFO - Running setup.py install for mozprofile 12:10:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:10:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:10:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:10:12 INFO - Running setup.py install for mozrunner 12:10:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:10:12 INFO - Running setup.py install for mozscreenshot 12:10:12 INFO - Running setup.py install for moztest 12:10:12 INFO - Running setup.py install for mozversion 12:10:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:10:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:10:12 INFO - Cleaning up... 12:10:12 INFO - Return code: 0 12:10:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:10:12 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')]} 12:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:12 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')]} 12:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:12 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 0x1de41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1facb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ed60>, '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 0x214fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', '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 12:10:12 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 12:10:12 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 12:10:12 INFO - Using env: {'DISPLAY': ':0', 12:10:12 INFO - 'HOME': '/home/cltbld', 12:10:12 INFO - 'LANG': 'en_US.UTF-8', 12:10:12 INFO - 'LANGUAGE': 'en_US:en', 12:10:12 INFO - 'LOGNAME': 'cltbld', 12:10:12 INFO - 'MAIL': '/var/mail/cltbld', 12:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:12 INFO - 'MOZ_NO_REMOTE': '1', 12:10:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:12 INFO - 'NO_EM_RESTART': '1', 12:10:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:12 INFO - 'PWD': '/builds/slave/test', 12:10:12 INFO - 'SHELL': '/bin/bash', 12:10:12 INFO - 'SHLVL': '1', 12:10:12 INFO - 'TERM': 'linux', 12:10:12 INFO - 'TMOUT': '86400', 12:10:12 INFO - 'USER': 'cltbld', 12:10:12 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', 12:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:12 INFO - '_': '/tools/buildbot/bin/python'} 12:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:10:12 INFO - Running setup.py (path:/tmp/pip-pFu4WO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:10:12 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)) 12:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:10:12 INFO - Running setup.py (path:/tmp/pip-k4TiQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:10:13 INFO - Running setup.py (path:/tmp/pip-HsTX_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:10:13 INFO - Running setup.py (path:/tmp/pip-7rt4Lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:10:13 INFO - Running setup.py (path:/tmp/pip-FQai6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:10:13 INFO - Running setup.py (path:/tmp/pip-THhA6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:10:13 INFO - Running setup.py (path:/tmp/pip-xwWiGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:10:13 INFO - Running setup.py (path:/tmp/pip-N3Yk1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:10:13 INFO - Running setup.py (path:/tmp/pip-e_UNU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:10:13 INFO - Running setup.py (path:/tmp/pip-K4nY9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:10:13 INFO - Running setup.py (path:/tmp/pip-lZQRY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:10:13 INFO - Running setup.py (path:/tmp/pip-WtF3ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:10:13 INFO - Running setup.py (path:/tmp/pip-fr1_0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:10:13 INFO - Running setup.py (path:/tmp/pip-qJNjCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:13 INFO - Running setup.py (path:/tmp/pip-Fk3bln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:13 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)) 12:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:10:13 INFO - Running setup.py (path:/tmp/pip-IpXb2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:10:14 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)) 12:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:10:14 INFO - Running setup.py (path:/tmp/pip-ZZk3Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:10:14 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)) 12:10:14 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)) 12:10:14 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)) 12:10:14 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)) 12:10:14 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)) 12:10:14 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)) 12:10:14 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)) 12:10:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:10:14 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 12:10:14 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 12:10:14 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 12:10:14 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 12:10:15 INFO - Downloading blessings-1.6.tar.gz 12:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:10:15 INFO - Installing collected packages: blessings 12:10:15 INFO - Running setup.py install for blessings 12:10:15 INFO - Successfully installed blessings 12:10:15 INFO - Cleaning up... 12:10:15 INFO - Return code: 0 12:10:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:10:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:10:15 INFO - Reading from file tmpfile_stdout 12:10:15 INFO - Current package versions: 12:10:15 INFO - argparse == 1.2.1 12:10:15 INFO - blessings == 1.6 12:10:15 INFO - blobuploader == 1.2.4 12:10:15 INFO - docopt == 0.6.1 12:10:15 INFO - functools32 == 3.2.3-2 12:10:15 INFO - jsonschema == 2.5.1 12:10:15 INFO - manifestparser == 1.1 12:10:15 INFO - mozInstall == 1.13 12:10:15 INFO - mozcrash == 1.0 12:10:15 INFO - mozdebug == 0.1 12:10:15 INFO - mozdevice == 0.51 12:10:15 INFO - mozfile == 1.2 12:10:15 INFO - mozhttpd == 0.7 12:10:15 INFO - mozinfo == 0.10 12:10:15 INFO - mozleak == 0.1 12:10:15 INFO - mozlog == 3.5 12:10:15 INFO - moznetwork == 0.27 12:10:15 INFO - mozprocess == 0.25 12:10:15 INFO - mozprofile == 0.28 12:10:15 INFO - mozrunner == 6.13 12:10:15 INFO - mozscreenshot == 0.1 12:10:15 INFO - mozsystemmonitor == 0.3 12:10:15 INFO - moztest == 0.8 12:10:15 INFO - mozversion == 1.4 12:10:15 INFO - psutil == 3.1.1 12:10:15 INFO - requests == 1.2.3 12:10:15 INFO - wsgiref == 0.1.2 12:10:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:15 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 0x1de41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1facb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ed60>, '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 0x214fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', '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 12:10:15 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 12:10:15 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 12:10:15 INFO - Using env: {'DISPLAY': ':0', 12:10:15 INFO - 'HOME': '/home/cltbld', 12:10:15 INFO - 'LANG': 'en_US.UTF-8', 12:10:15 INFO - 'LANGUAGE': 'en_US:en', 12:10:15 INFO - 'LOGNAME': 'cltbld', 12:10:15 INFO - 'MAIL': '/var/mail/cltbld', 12:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:15 INFO - 'MOZ_NO_REMOTE': '1', 12:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:15 INFO - 'NO_EM_RESTART': '1', 12:10:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:15 INFO - 'PWD': '/builds/slave/test', 12:10:15 INFO - 'SHELL': '/bin/bash', 12:10:15 INFO - 'SHLVL': '1', 12:10:15 INFO - 'TERM': 'linux', 12:10:15 INFO - 'TMOUT': '86400', 12:10:15 INFO - 'USER': 'cltbld', 12:10:15 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', 12:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:15 INFO - '_': '/tools/buildbot/bin/python'} 12:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:15 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)) 12:10:15 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)) 12:10:15 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)) 12:10:15 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)) 12:10:15 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)) 12:10:15 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)) 12:10:15 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)) 12:10:15 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)) 12:10:15 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)) 12:10:15 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:10: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 12:10: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 12:10: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 12:10: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 12:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:10:17 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)) 12:10:17 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)) 12:10:17 INFO - Installing collected packages: simplejson 12:10:17 INFO - Running setup.py install for simplejson 12:10:17 INFO - building 'simplejson._speedups' extension 12:10:17 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 12:10:17 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 12:10:18 INFO - Successfully installed simplejson 12:10:18 INFO - Cleaning up... 12:10:18 INFO - Return code: 0 12:10:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:10:18 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')]} 12:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:18 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')]} 12:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:18 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 0x1de41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1facb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214ed60>, '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 0x214fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fef0>, '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': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', '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 12:10:18 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 12:10:18 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 12:10:18 INFO - Using env: {'DISPLAY': ':0', 12:10:18 INFO - 'HOME': '/home/cltbld', 12:10:18 INFO - 'LANG': 'en_US.UTF-8', 12:10:18 INFO - 'LANGUAGE': 'en_US:en', 12:10:18 INFO - 'LOGNAME': 'cltbld', 12:10:18 INFO - 'MAIL': '/var/mail/cltbld', 12:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:18 INFO - 'MOZ_NO_REMOTE': '1', 12:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:18 INFO - 'NO_EM_RESTART': '1', 12:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:18 INFO - 'PWD': '/builds/slave/test', 12:10:18 INFO - 'SHELL': '/bin/bash', 12:10:18 INFO - 'SHLVL': '1', 12:10:18 INFO - 'TERM': 'linux', 12:10:18 INFO - 'TMOUT': '86400', 12:10:18 INFO - 'USER': 'cltbld', 12:10:18 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', 12:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:18 INFO - '_': '/tools/buildbot/bin/python'} 12:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:10:18 INFO - Cleaning up... 12:10:18 INFO - Return code: 0 12:10:18 INFO - Running post-action listener: _resource_record_post_action 12:10:18 INFO - Running post-action listener: _start_resource_monitoring 12:10:18 INFO - Starting resource monitoring. 12:10:18 INFO - [mozharness: 2017-09-25 19:10:18.352156Z] Finished create-virtualenv step (success) 12:10:18 INFO - [mozharness: 2017-09-25 19:10:18.352631Z] Running install step. 12:10:18 INFO - Running pre-action listener: _resource_record_pre_action 12:10:18 INFO - Running main action method: install 12:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:10:18 INFO - Reading from file tmpfile_stdout 12:10:18 INFO - Detecting whether we're running mozinstall >=1.0... 12:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:10:18 INFO - Reading from file tmpfile_stdout 12:10:18 INFO - Output received: 12:10:18 INFO - Usage: mozinstall [options] installer 12:10:18 INFO - Options: 12:10:18 INFO - -h, --help show this help message and exit 12:10:18 INFO - -d DEST, --destination=DEST 12:10:18 INFO - Directory to install application into. [default: 12:10:18 INFO - "/builds/slave/test"] 12:10:18 INFO - --app=APP Application being installed. [default: firefox] 12:10:18 INFO - mkdir: /builds/slave/test/build/application 12:10:18 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'] 12:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:10:36 INFO - Reading from file tmpfile_stdout 12:10:36 INFO - Output received: 12:10:36 INFO - /builds/slave/test/build/application/firefox/firefox 12:10:36 INFO - Running post-action listener: _resource_record_post_action 12:10:36 INFO - [mozharness: 2017-09-25 19:10:36.263965Z] Finished install step (success) 12:10:36 INFO - [mozharness: 2017-09-25 19:10:36.264217Z] Running setup-mitmproxy step. 12:10:36 INFO - Running pre-action listener: _resource_record_pre_action 12:10:36 INFO - Running main action method: setup_mitmproxy 12:10:36 INFO - Skipping: mitmproxy is not required 12:10:36 INFO - Running post-action listener: _resource_record_post_action 12:10:36 INFO - [mozharness: 2017-09-25 19:10:36.265356Z] Finished setup-mitmproxy step (success) 12:10:36 INFO - [mozharness: 2017-09-25 19:10:36.265578Z] Running run-tests step. 12:10:36 INFO - Running pre-action listener: _resource_record_pre_action 12:10:36 INFO - Running pre-action listener: _set_gcov_prefix 12:10:36 INFO - Running main action method: run_tests 12:10:36 WARNING - Try message not found. 12:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:10:36 INFO - Python 2.7.3 12:10:36 INFO - Return code: 0 12:10:36 INFO - grabbing minidump binary from tooltool 12:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:10:36 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 0x214ed60>, '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 0x214fa60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:10:36 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 12:10:36 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 12:10:36 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 12:10:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:10:36 INFO - Return code: 0 12:10:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:10:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:10:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:10:36 INFO - ENV: RUST_BACKTRACE is now full 12:10:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:10:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 12:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-070 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 12:10:36 INFO - Using env: {'DISPLAY': ':0', 12:10:36 INFO - 'HOME': '/home/cltbld', 12:10:36 INFO - 'LANG': 'en_US.UTF-8', 12:10:36 INFO - 'LANGUAGE': 'en_US:en', 12:10:36 INFO - 'LOGNAME': 'cltbld', 12:10:36 INFO - 'MAIL': '/var/mail/cltbld', 12:10:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:10:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:36 INFO - 'MOZ_NO_REMOTE': '1', 12:10:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:36 INFO - 'NO_EM_RESTART': '1', 12:10:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:36 INFO - 'PWD': '/builds/slave/test', 12:10:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:10:36 INFO - 'RUST_BACKTRACE': 'full', 12:10:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:10:36 INFO - 'SHELL': '/bin/bash', 12:10:36 INFO - 'SHLVL': '1', 12:10:36 INFO - 'TERM': 'linux', 12:10:36 INFO - 'TMOUT': '86400', 12:10:36 INFO - 'USER': 'cltbld', 12:10:36 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', 12:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:36 INFO - '_': '/tools/buildbot/bin/python'} 12:10:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 12:10:36 INFO - mozversion application_buildid: 20170925174106 12:10:36 INFO - mozversion application_changeset: 33b7b8e81b4befcba503c0e48cd5370aeb715085 12:10:36 INFO - mozversion application_display_name: Nightly 12:10:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:10:36 INFO - mozversion application_name: Firefox 12:10:36 INFO - mozversion application_remotingname: firefox 12:10:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:10:36 INFO - mozversion application_vendor: Mozilla 12:10:36 INFO - mozversion application_version: 58.0a1 12:10:36 INFO - mozversion platform_buildid: 20170925174106 12:10:36 INFO - mozversion platform_changeset: 33b7b8e81b4befcba503c0e48cd5370aeb715085 12:10:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:10:36 INFO - mozversion platform_version: 58.0a1 12:10:36 INFO - using testdate: 1506366636 12:10:36 INFO - actual date: 1506366636 12:10:36 INFO - starting webserver on 'localhost:48650' 12:10:36 INFO - SUITE-START | Running 2 tests 12:10:36 INFO - TEST-START | dromaeo_css 12:10:36 INFO - Initialising browser for dromaeo_css test... 12:10:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48650/getInfo.html -profile /tmp/tmpjD65GN/profile 12:10:36 INFO - TEST-INFO | started process 24098 (/builds/slave/test/build/application/firefox/firefox http://localhost:48650/getInfo.html) 12:10:42 INFO - TEST-INFO | 24098: exit 0 12:10:42 INFO - Browser initialized. 12:10:42 INFO - Running cycle 1/1 for dromaeo_css test... 12:10:42 INFO - Using env: {'DISPLAY': ':0', 12:10:42 INFO - 'HOME': '/home/cltbld', 12:10:42 INFO - 'JSGC_DISABLE_POISONING': '1', 12:10:42 INFO - 'LANG': 'en_US.UTF-8', 12:10:42 INFO - 'LANGUAGE': 'en_US:en', 12:10:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:10:42 INFO - 'LOGNAME': 'cltbld', 12:10:42 INFO - 'MAIL': '/var/mail/cltbld', 12:10:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:10:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:10:42 INFO - 'MOZ_CRASHREPORTER': '1', 12:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:10:42 INFO - 'MOZ_NO_REMOTE': '1', 12:10:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:10:42 INFO - 'NO_EM_RESTART': '1', 12:10:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:42 INFO - 'PWD': '/builds/slave/test', 12:10:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:10:42 INFO - 'RUST_BACKTRACE': 'full', 12:10:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:10:42 INFO - 'SHELL': '/bin/bash', 12:10:42 INFO - 'SHLVL': '1', 12:10:42 INFO - 'STYLO_FORCE_DISABLED': '1', 12:10:42 INFO - 'TERM': 'linux', 12:10:42 INFO - 'TMOUT': '86400', 12:10:42 INFO - 'USER': 'cltbld', 12:10:42 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', 12:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:42 INFO - '_': '/tools/buildbot/bin/python'} 12:10:42 INFO - TEST-INFO | started process 24339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjD65GN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:10:43 INFO - PID 24339 | 12:10:43 INFO - PID 24339 | (/builds/slave/test/build/application/firefox/firefox:24389): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:10:43 INFO - PID 24339 | 12:10:53 INFO - PID 24339 | RSS: Main: 144564224 12:10:53 INFO - PID 24339 | 12:13:51 INFO - PID 24339 | Cycle 1(1): loaded http://localhost:48650/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48650/tests/dromaeo/cssquery-ext.html) 12:13:52 INFO - PID 24339 | RSS: Main: 146337792 12:13:52 INFO - PID 24339 | 12:16:54 INFO - PID 24339 | Cycle 1(1): loaded http://localhost:48650/tests/dromaeo/cssquery-ext.html (next: http://localhost:48650/tests/dromaeo/cssquery-jquery.html) 12:16:54 INFO - PID 24339 | RSS: Main: 146034688 12:16:54 INFO - PID 24339 | 12:19:56 INFO - PID 24339 | Cycle 1(1): loaded http://localhost:48650/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48650/tests/dromaeo/cssquery-mootools.html) 12:19:57 INFO - PID 24339 | RSS: Main: 148299776 12:19:57 INFO - PID 24339 | 12:22:58 INFO - PID 24339 | Cycle 1(1): loaded http://localhost:48650/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48650/tests/dromaeo/cssquery-prototype.html) 12:22:59 INFO - PID 24339 | RSS: Main: 145977344 12:22:59 INFO - PID 24339 | 12:26:02 INFO - PID 24339 | Cycle 1(1): loaded http://localhost:48650/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48650/tests/dromaeo/cssquery-yui.html) 12:26:03 INFO - PID 24339 | RSS: Main: 148074496 12:26:03 INFO - PID 24339 | 12:29:04 INFO - PID 24339 | Cycle 1(1): loaded http://localhost:48650/tests/dromaeo/cssquery-yui.html (next: http://localhost:48650/tests/dromaeo/cssquery-dojo.html) 12:29:04 INFO - PID 24339 | RSS: Main: 149012480 12:29:04 INFO - PID 24339 | 12:29:04 INFO - PID 24339 | __start_tp_report 12:29:04 INFO - PID 24339 | _x_x_mozilla_page_load 12:29:04 INFO - PID 24339 | _x_x_mozilla_page_load_details 12:29:04 INFO - PID 24339 | |i|pagename|runs| 12:29:04 INFO - PID 24339 | |0;dojo.html;3857.9421308680376;3888.552816426112;3896.337622604155;3905.7851818149998;3909.1009067914397;6193.566450348478;6241.25104987401;6288.842778930529;6324.841878953022;6377.681115944201;6360;6371.916774148394;6374.553781235315;6416.775412860551;6425.036244563318;5676.489115979561;5685.914711279334;5690.57320700947;5709.400512946143;5714.342850572196;5583.162525621169;5622.718864056801;5626.746796394152;5628;5676.574256930726;5586.469285417878;5665.348484924245;5676.574256930726;5700.429957004308;5727.513161381287;5378.273933019071;5489.560835133179;5519.227308176858;5561.221428999943;5588.357338906017;5504.366997795265;5509.842932984078;5526.50261476465;5566.359868615121;5617.017022021171;6237.968810155966;6252.437280644718;6259.186305780265;6282.403171698681;6331.968340158316;6694.83262918426;6753.392194702451;6797.048413222153;6803.115594972622;6826.863462730717;6873.072135261776;6873.5875847449315;6875.965620171917;6876.312368763134;6885.380315771555;6361.459275961549;6386.393292637192;6396.776112836075;6435.806925792233;6445;6935.4104901082965;6967.79096627102;7030.613316267552;7060.293970602898;7067.787966361017;6751.358620931003;6797.422219111431;6831.487638427038;6872.381485666314;6874.2782007889455;6762.72949082041;6803.863922721518;6806.421454176351;6807.217170025411;6817.727290908408;6764.594124352555;6796.286389928986;6827.590344579341;6830.829229269308;6831.316868313228;6695.296993815677;6799;6805.251422343538;6821.590704557643;6833.965830170818;4990.925136122961;4991.401031876198;5048.217526283432;5058.089543882136;5059.544640982329;4493.303537951622;4527.139843429738;4569.13186494565;4581.862544123682;4594.517575654575;6234.314225435199;6251;6257.906131408033;6303.684815759194;6324.557280990287;6855.245922948472;6872.931270687329;6898.965505172442;6914.827129321807;6919.4464442844455;6232.439080482778;6244.562880598314;6313.463355614732;6323.52573556985;6370.362963703686;5456.6725996439545;5491.615586908878;5505.889882202334;5564.638298510584;5575.804846830422;7103.183133939559;7103.325184107502;7199.496035277585;7202.027726256993;7217.097862767154;6859.142607174103;6863;6905.136857892763;6937.7224911002995;6938.548994315555;7078.4691148163065;7090.858182836211;7103;7202.89195662055;7205;6660.234073081658;6735.158105236846;6747.190337159573;6769.966150169218;6770;6747.359000894907;6757.526973112032;6767.458603311625;6770.424513916372;6774.729010839708;6570.671466426564;6594.373534514213;6653.334666533308;6659.567128136656;6676;6588.308227636029;6619.735210591522;6622.735090596322;6693.698783554849;6709.530332876652;6420.101185833893;6495.188101487314;6508.642024688687;6516.771912983023;6603;6653.135092437952;6692.029655699994;6718.8320291993095;6722.361375669304;6737.393634572912;6356.237251529846;6449;6478.060681201106;6519.282878883414;6569.605823650596 12:29:04 INFO - PID 24339 | |1;ext.html;927.2720914082447;950.7432993091861;973.9269554783391;1006.2905651515682;1008.2236677758126;41675;42063.57936420635;42098.368524472084;42351;42583.14833703328;42768.57231427693;43122.35316470255;43180.568194318046;43216.78391608038;43255.35116973248;8288.171182881724;8489.66041358345;8515.95742021289;8526.190011948886;8529.701460448885;8338.583070846464;8462.026866910292;8489.575521223915;8491.830163396728;8494.235518803307;8424.073351931283;8436.662533498684;8444.704435344764;8446.450980686266;8497.575121243945;8411.242988131067;8442.366822488277;8443.662253509852;8450.239478446938;8452.450590711614;7781.805454863617;7906.130325664172;7924.009498812648;7927.207279272026;7932.920670793276;39334.60665393338;39350.80324598359;39750;39779.80110099431;39793;3603.8017909014993;3678.4850120983083;3701.592824789298;3705.5368078990127;3723.4600982857605;32343.676563234538;32443.351132977445;32452.67547324544;32556.511652325233;32748.508772368434;5426;5437.728113594344;5459.426760190202;5465.043617366985;5491;214418;214536;215056.92471537698;216015;216486;48523.272150917765;49488.50511494911;49598.75200623974;51309.743451282506;51796.482035179164;53407.46592534103;53426.46573534293;53666.19500707492;53718;53843.46156538385;16769;16909.915450422668;17100.888442251213;17139;17151.914240428967;13878.375473103735;13947.442102315998;13963.720725585432;13964.860351396559;13984.720305593832;15280.694386112216;15281.159536225614;15290.464833730766;15309.846901530842;15488.303026363841;5851.853703657443;5956.583039187302;6049.879002419927;6078.969605151946;6152.723127459275;1089.2048804372853;1095.2552264460244;1102.5424448853796;1112.1380929779325;1118.457548089176;25389.36526586813;25416.872915635675;25463.36341591475;25562.744372556408;25606.871965640425;1210.7672514386609;1218.287301928364;1221.8717034711228;1223.6512593910693;1239.5475651387178;13504.122232054886;13575;13582.524611638546;13755.587332380044;13805.654858628615;271496;272506;272568;290630;293037;58998.410015900154;59443;59455.702721486115;59460;59709.104363434584;1509.562226954193;1516.2797671106136;1519.9848001520065;1523.8095238095239;1531.364483739258;30019.249518762204;30184.396312074074;30320.090397288117;30360.240993975327;30764.846175768977;39661.60338396579;39889;39930.60069399269;39950;40011.999700007735;222723;223759;223870;224489;225056;35197.944061678194;35638.465423018155;35972.4604130933;36191.638083618825;36228.09429764277;43616;44195.77902110469;44425.55574444344;44570.55429445664;44714.3292850601;32529.837350813094;32897.34205315928;33015.17462063468;33039.50440743439;33039.83480082584;32204.516932245566;32601.510977334885;32676.183095421853;32903.506447402826;32930;37982;38388.232235354575;38395.80802095972;38658.42012369761;38764.22471550497;31142.221444463165;31846;31972;32319.838400807846;32608;24993.250472466752;25063.373415664755;25475.235742927744;25610.743892560837;25718.485630286916 12:29:04 INFO - PID 24339 | |2;jquery.html;574.523145788995;598.6228675934161;617.8702472480779;620.7889317632006;629.6159342800892;22306.776932230674;23310.88344558277;23320.766792332113;23332.183373581927;23345.883270583643;24731.629025564587;27229.319267018334;27434.314142146457;27473;27473.86263068687;6708.127943367355;6867.313268673118;6869.587824730507;6872.34712702295;6872.896906546381;6603.867922641544;6735.932640673604;6804.319568043181;6819.829504262383;6820.147481564804;6771.559848609824;6785.287544807798;6785.423239024689;6806.319368063178;6812.693428795691;6643.1363922690225;6794.796156115324;6799.592024478522;6818.897716534256;6877.6217308048035;6418.679066046726;6419.390157934989;6422.389872962061;6424.100625912376;6429.967850160766;31659.20851978719;31851.52222716661;31862.362752745048;32112;32133.357332853448;2197.4067001909557;2220.855644383126;2226.398872304485;2232.430730163814;2234.4078819112947;20246.49383765403;21142.365729028155;21190.576188476298;21206.787932120635;21225.726456412664;2538.21315392229;2560.3343130785943;2577.80666450017;2617.175589689242;2627.8423294602194;134769;141661;148910;152857;155347;16463;16877.662446750997;17067.743983840253;17146.3992561561;17418.82581174172;26248;26360.34099147537;26378.472430551283;26425.075122370625;26496.205113846616;11237.157213209042;11248.94375528117;11382.089432845352;11389.772204555862;11601.419929003516;10187;10204.336718113298;10360.948195259127;10369.222308326905;10409.115225205791;9971.252156088321;10079.647212347532;10183.796324073624;10478.161747060218;10545.209109316833;2912.538904625588;2921.4595299869166;2934.281101130194;2936.7797415193945;3034.620672415948;1054.093479607537;1064.1433645914958;1080.5029686344212;1084.8860869608577;1091.912646988239;22595;22921.885390573272;23092.53814923692;23125.306240812803;23224.954877030574;1119.1941801902617;1122.3882983773863;1125.7129431994788;1135.4663308245113;1142.7771584540935;12062.51749929993;12296.385180741107;12487.250764954131;12496.312702801433;12534.74930501385;516229;547963;554380;556139;556683;124223;126551;128711.35644321718;129343;131561;1225.4240506961892;1239.1016513027982;1264.462603393554;1273.9426725797362;1278.0606254403006;19252.326168584033;19415.90292048587;19462.416127516197;19471.4158575243;19642.50893727668;63203;64267.67866160639;64778.67610661917;66295.66852165708;66861.33138668552;82918;83388;83744;84309;84938.57530712555;16334.101624410772;16370.263338149574;16462.83537164613;16496.42262520806;16511.174441277646;25146.24561263165;25476;25560.23319300424;25742.613860792477;25840.741592583832;20333.89833050825;20505.077271522518;20596.588068238852;20855.478613034797;20856.165753369696;18118.909405453414;18310.176042078405;18387.448376548724;18471.445856624323;18730.812691873452;20630.17479300811;20669.276575319793;21261.255856044965;21281.829499377684;21377.67933480968;15824.44614438489;16083.195840208176;16089.356425742839;16176.757348639545;16189.271482783068;20097.296594619118;20225.59548809045;20267.391978240677;20288.797112029282;20413.48966275855 12:29:04 INFO - PID 24339 | |3;mootools.html;1412.1244828206513;1457.7740450230212;1481.7240797530783;1482.6664000599874;1495.887808414369;16755.32978680853;17372.739408908845;17395.47813565595;17410.82589174108;17430.912845435756;16942.661146777056;16981.660366792657;17012.48962531126;17016.574585635335;17031.403900863443;2846;2906.229849089982;2907.200519857035;2909.3163106669917;2909.7381235688786;2780.3605170810724;2896.6089577906923;2897.5943367928508;2901.7968742188054;2903.8693258803405;2826.4488424757183;2932.8533573321356;2934.0464349086524;2934.1344303430433;2935.6183696119583;2879.078694817659;2898.3913378190605;2900.173450566589;2920.7517361024234;2944.263934016496;2734.9179524614096;2766.7648249898784;2770.667519897605;2772.182206249141;2772.514809908278;16373.91813040939;16610.916945415196;16712.58218544534;16745.748813767805;16756.329746810112;8349.624266908004;8562.100979397135;8603.870941935877;8643.611037503328;8667;5461.644993075437;5866.178734977107;5930.466258036754;5946.732397042144;6040.456358927718;2080.4278823323557;2112.535242246703;2123.3736047865764;2163.0698799516204;2176.749673787519;29716.405671886656;29928.99999999978;30055.69944300551;30103.69896301031;30127.69872301271;7147.249538798351;7329.633518324063;7333.669984850694;7510.361619262424;7516.285952834472;19252.4224273272;19288;19296.1316740747;19306.90346548258;19310.03449827503;8276.08963014068;8804.295656347476;9023.233025192802;9084.137006984325;9097.499637519868;7956.801079972931;7981.08217554977;8028.4781489203015;8033.156518565466;8036.799080022929;6012.549058820606;6224.813255602339;6229.937700623026;6256.906146407808;6357;1769.4337811900068;1846.4645252876785;1881.8682692211414;1914.9904250478658;1947.51312171957;915.2037727177399;938.3666025432806;939.8825146856643;943.2736792669606;944.5182956691999;9430.90569094314;9805;9830.164436023018;9895.60417583303;10133.543990520444;1037.8080055189814;1083.822213383716;1090.3730355045723;1106.164845541611;1113.0038615439137;5570.972145139248;5813.593048486566;5841.532677385799;5939.316978547436;6033.276006879202;23800.523989520458;24250.87874560616;24295.757042429705;24542.509149817262;24733.381665458506;23781.643275350885;24300;24424;24577.631335529983;24650.50698986046;12772.680682983;12781.61655150347;12868.356582171042;13086.476540938445;13087.149335293176;9367.203787678123;9499.38254013487;9600.711978640651;9606.327557070937;9698.9030109698;20669.483262917947;21023.579528409653;21500.89249553742;21574.676379854;21878.89060554687;21524.354269371943;21726.891365543703;22059;22405;22639.88680056589;13325.933370333087;13481;13485.46058157702;13495.662608434868;13500.797488037491;14997.87515936331;15020.849791502382;15040.623984400478;15090.54728358151;15119.16844573559;12335.876641233473;12352;12414.81377779352;12669.873301266869;12723.23660580368;12081.939590301992;12192.451339689913;12296.938515307365;12555.12114152037;12670.366481676063;10592.576296948037;10600.25798194119;10696.411697356409;10793.946030269799;10798.73003174927;8072.273495385443;8081.15147909461;8115.188481151838;8237.752867413987;8240.546769927472;8369;8376.162383761575;8436;8472.830543388975;8575.656973720981 12:29:04 INFO - PID 24339 | |4;prototype.html;546.7102435709076;568.2413977340251;576.1933293389258;580.1993249315944;584.2492397269507;6280.905786413202;6309.053641953709;6339.334369891153;6409.4551963083195;6464.3212462691445;6187;6207.255129384469;6220.875582488347;6314.1475900753385;6340.873182536347;4944.802207911697;5170.353705786777;5186.92219616706;5193.298904647881;5195.610329225305;4965.726885021322;4998.275250088753;5059.671121377099;5070.923936140961;5074.391073071218;4989.276554899538;5003.274525193845;5007.324011258488;5017.69893806371;5025.673331233476;5003.374578177728;5029.3964724232965;5038.143515602356;5048.419431765357;5082.720450375228;4590.242609969385;4596.47140578831;4605.953940460586;4616.561426664462;4622.098690755304;6116.816495505142;6161.599496032743;6251.562390632657;6328.968470066308;6341.112244285804;5925.503952667947;5936.584439089265;5954.821355359346;5961.821145365646;5973.671448070398;6791.592504449749;6804.08144900442;6810.182778066664;6828.419584335337;6830.760923367708;5099.464556221617;5115.7442127893455;5145.562627176694;5156.355455568054;5158.277841102249;6769.458443324522;6795.694193761293;6826.965865170741;6980.441564674814;6980.546264492792;5209.921851172159;5227.60792940531;5243.9213411798855;5265.447128051576;5276.973615131899;5271.4728527147745;5336.7865285388925;5340.8397748066845;5381.165919282517;5393.460653934575;5865.266841644794;5880.323762767251;5935.792247271324;5936.168936348915;5965.850853728604;6756.020377045301;6792.252852186256;6800.557963732342;6812.965935170292;6828.52200345981;1815.6005678750653;1834.660587791263;1835.8072402397822;1844.124041080476;1846.3906910719431;1208.9637310880687;1287.9484820607258;1295.3846922711825;1300.2133709106045;1317.1109501086728;6176.197094377702;6180.8763824723255;6182.474489668429;6221.471174950089;6318.8420289492215;6169.549870451356;6684.632345220963;6744.325567443217;6801.863962720718;6855.177378714586;6008.369121242294;6156.907646385308;6222.595531290452;6227.96886015567;6280.791869447481;3571.285782824259;3575.8748443804343;3582.570091589026;3597.712183025352;3610.6389361063684;6922.203946546211;6924.826879328057;7042.190148133031;7090.893636595455;7128.215896251409;6905.585664860125;6947.270536593686;6974.755883544051;6978.3831063351245;7000.789976300719;6977.79066628002;7041.859162816715;7057.435405167575;7067.57594544329;7081;6660.134182556237;6664.8000559983275;6668.299828517936;6669.266380698216;6731.4951378647775;6670.199576050905;6699.196096468455;6704.363085506869;6716.899246511404;6750.628715420503;7019.684114214975;7057.435405167677;7062.15254169503;7093.574385536885;7098.822529436806;5174.120399532013;5193.75349916025;5202.947970520398;5231.581473482036;5255.264263003259;6615.437687796399;6723.125993620798;6768.4585233182215;6780.372710549531;6799.524033317818;6331.841703957438;6537.673116344069;6578.407943285128;6598.307177746459;6684.598924064571;6484.935150648433;6512.3017359810165;6594.142761441174;6604.447954730538;6620.437262832713;6476.902846457213;6495.480361570969;6556.967340124576;6560.507961902781;6576.473882089325;6626.635535045619;6666.233448136345;6694.59832410057;6725.43551917465;6739.326067393417;6416.679166041586;6439.162908822011;6451.322656109352;6501.51238657112;6525.477961762953 12:29:04 INFO - PID 24339 | |5;yui.html;931.9161275485205;951.3103000324766;981.1513041219346;997.6258902911409;1009.9545520451579;20308;20802.895985520052;20831.166753329868;20836.89581552094;20855.061522231517;14413.783793243083;14477.493287734906;14483.275836208173;14531.564053078424;14681.559553213394;1067.6423398161626;1092.180864351736;1093.6008356949696;1094.9726256843562;1095.5508241620937;1084.8426978088173;1089.0797276301512;1090.9618163364244;1091.0671375973548;1092.9180311476632;1086.2504871638585;1122.2480937771672;1131.3042478875473;1131.3664347965125;1132.4620805117545;1119.1829964126152;1120.6918097523164;1121.058311018744;1121.7476067884702;1122.6632010396847;797.5812698333364;813.2721214512977;820.8358328334357;822.440740296598;826.2563692676579;19715.40853774389;19795.30716424918;19855.602887942303;19863;20011;23221.76778232213;23355.182568610016;23802.285931422084;23888.402789930216;23901.521969560687;17982.190801413835;18087.909560452114;18201.817981820277;18264.45206643803;18265.45203643893;3975.0062484378905;3986.920261594781;3993.0815912340327;4002.5397079335667;4003.1393250451;129455;159530.2023489875;161071;161695;165762;19002.23991040343;19069.237230510626;19477.513062173275;19629.8037019628;19651.213951442067;34995.12512187165;35460.64539354625;35588.110297242776;35775.82112089423;36057.0985725359;9684.661036863676;9739.756506087404;9859.950700246452;9912.207023438108;9947.10476057144;4673.112108699336;4740.2178640523925;4777.522247775264;4791.808327666854;4807.807687692453;6114.052321890114;6154.3845615438995;6165.5375846810775;6210.813675589739;6248.156498872685;1253.6239128261484;1280.1231156657534;1303.6284658872175;1308.8756568126014;1312.645585691877;705.1925545250659;707.2079271216271;715.0954043135438;727.3998950865557;733.6185183704443;13083.934580327037;13487.393067311994;13780.379882905294;14307.356168972421;14410.855891440951;695.391532409142;716.3946465236867;720.5712601002396;722.5664601239214;736.6942718771757;5818.94181058184;5821.650700957956;5912.083627037816;6003.879922401527;6061.424164704346;148412;150951.24524377307;151869;153614;156176;130274;133171.33414332866;133580;133869;139667;110548.4472577632;110733.44633276942;111025.44487277512;111836.44081779702;112598;10977.780444390908;11026.338419694845;11091.33451992883;11111.666650000512;11353.772924541297;53923.573439196116;53959.19061214006;54493.45506545043;54883.45116548943;55444.72277638586;64397.67801161152;65841.67079164574;68518.65740671464;69163.65418172877;69314;15698.843011569737;15872.76190857115;16020.519384418487;16093.597660058593;16094.597635059217;17274.395396161075;17595.56011099733;17814.46556603304;17897.552561186076;17995.73006404879;16806.747898781283;16895.66208675795;16933.830661693224;16966.236519356906;17114.657706846043;17361.131943402528;17550;17647.20587573588;17672.293108275524;17750.378736744668;18051.18769655395;18189.909050454662;18219.908900455943;18300.790191277913;18418.17118229656;14339.569812905629;14489.347979340744;14503.1298122113;14507.274636268356;14519.274036298355;13496.392662330023;13597.456101755819;13605.387757550736;13620.591382258548;13735.175889446666 12:29:04 INFO - PID 24339 | __end_tp_report 12:29:04 INFO - PID 24339 | __start_cc_report 12:29:04 INFO - PID 24339 | _x_x_mozilla_cycle_collect,290 12:29:04 INFO - PID 24339 | __end_cc_report 12:29:04 INFO - PID 24339 | __startTimestamp1506367744679__endTimestamp 12:29:04 INFO - PID 24339 | 12:29:04 INFO - PID 24339 | ------- Summary: start ------- 12:29:04 INFO - PID 24339 | Number of tests: 6 12:29:04 INFO - PID 24339 | 12:29:04 INFO - PID 24339 | [#0] dojo.html Cycles:165 Average:6285.26 Median:6519.28 stddev:754.76 (11.6%) stddev-sans-first:732.66 12:29:04 INFO - PID 24339 | Values: 3857.9 3888.6 3896.3 3905.8 3909.1 6193.6 6241.3 6288.8 6324.8 6377.7 6360.0 6371.9 6374.6 6416.8 6425.0 5676.5 5685.9 5690.6 5709.4 5714.3 5583.2 5622.7 5626.7 5628.0 5676.6 5586.5 5665.3 5676.6 5700.4 5727.5 5378.3 5489.6 5519.2 5561.2 5588.4 5504.4 5509.8 5526.5 5566.4 5617.0 6238.0 6252.4 6259.2 6282.4 6332.0 6694.8 6753.4 6797.0 6803.1 6826.9 6873.1 6873.6 6876.0 6876.3 6885.4 6361.5 6386.4 6396.8 6435.8 6445.0 6935.4 6967.8 7030.6 7060.3 7067.8 6751.4 6797.4 6831.5 6872.4 6874.3 6762.7 6803.9 6806.4 6807.2 6817.7 6764.6 6796.3 6827.6 6830.8 6831.3 6695.3 6799.0 6805.3 6821.6 6834.0 4990.9 4991.4 5048.2 5058.1 5059.5 4493.3 4527.1 4569.1 4581.9 4594.5 6234.3 6251.0 6257.9 6303.7 6324.6 6855.2 6872.9 6899.0 6914.8 6919.4 6232.4 6244.6 6313.5 6323.5 6370.4 5456.7 5491.6 5505.9 5564.6 5575.8 7103.2 7103.3 7199.5 7202.0 7217.1 6859.1 6863.0 6905.1 6937.7 6938.5 7078.5 7090.9 7103.0 7202.9 7205.0 6660.2 6735.2 6747.2 6770.0 6770.0 6747.4 6757.5 6767.5 6770.4 6774.7 6570.7 6594.4 6653.3 6659.6 6676.0 6588.3 6619.7 6622.7 6693.7 6709.5 6420.1 6495.2 6508.6 6516.8 6603.0 6653.1 6692.0 6718.8 6722.4 6737.4 6356.2 6449.0 6478.1 6519.3 6569.6 12:29:04 INFO - PID 24339 | 12:29:04 INFO - PID 24339 | [#1] ext.html Cycles:180 Average:41630.71 Median:19897.72 stddev:62729.65 (315.3%) stddev-sans-first:62831.17 12:29:04 INFO - PID 24339 | Values: 927.3 950.7 973.9 1006.3 1008.2 41675.0 42063.6 42098.4 42351.0 42583.1 42768.6 43122.4 43180.6 43216.8 43255.4 8288.2 8489.7 8516.0 8526.2 8529.7 8338.6 8462.0 8489.6 8491.8 8494.2 8424.1 8436.7 8444.7 8446.5 8497.6 8411.2 8442.4 8443.7 8450.2 8452.5 7781.8 7906.1 7924.0 7927.2 7932.9 39334.6 39350.8 39750.0 39779.8 39793.0 3603.8 3678.5 3701.6 3705.5 3723.5 32343.7 32443.4 32452.7 32556.5 32748.5 5426.0 5437.7 5459.4 5465.0 5491.0 214418.0 214536.0 215056.9 216015.0 216486.0 48523.3 49488.5 49598.8 51309.7 51796.5 53407.5 53426.5 53666.2 53718.0 53843.5 16769.0 16909.9 17100.9 17139.0 17151.9 13878.4 13947.4 13963.7 13964.9 13984.7 15280.7 15281.2 15290.5 15309.8 15488.3 5851.9 5956.6 6049.9 6079.0 6152.7 1089.2 1095.3 1102.5 1112.1 1118.5 25389.4 25416.9 25463.4 25562.7 25606.9 1210.8 1218.3 1221.9 1223.7 1239.5 13504.1 13575.0 13582.5 13755.6 13805.7 271496.0 272506.0 272568.0 290630.0 293037.0 58998.4 59443.0 59455.7 59460.0 59709.1 1509.6 1516.3 1520.0 1523.8 1531.4 30019.2 30184.4 30320.1 30360.2 30764.8 39661.6 39889.0 39930.6 39950.0 40012.0 222723.0 223759.0 223870.0 224489.0 225056.0 35197.9 35638.5 35972.5 36191.6 36228.1 43616.0 44195.8 44425.6 44570.6 44714.3 32529.8 32897.3 33015.2 33039.5 33039.8 32204.5 32601.5 32676.2 32903.5 32930.0 37982.0 38388.2 38395.8 38658.4 38764.2 31142.2 31846.0 31972.0 32319.8 32608.0 24993.3 25063.4 25475.2 25610.7 25718.5 12:29:04 INFO - PID 24339 | 12:29:04 INFO - PID 24339 | [#2] jquery.html Cycles:180 Average:38523.97 Median:2223.63 stddev:91944.14 (4134.9%) stddev-sans-first:92157.91 12:29:04 INFO - PID 24339 | Values: 574.5 598.6 617.9 620.8 629.6 22306.8 23310.9 23320.8 23332.2 23345.9 24731.6 27229.3 27434.3 27473.0 27473.9 6708.1 6867.3 6869.6 6872.3 6872.9 6603.9 6735.9 6804.3 6819.8 6820.1 6771.6 6785.3 6785.4 6806.3 6812.7 6643.1 6794.8 6799.6 6818.9 6877.6 6418.7 6419.4 6422.4 6424.1 6430.0 31659.2 31851.5 31862.4 32112.0 32133.4 2197.4 2220.9 2226.4 2232.4 2234.4 20246.5 21142.4 21190.6 21206.8 21225.7 2538.2 2560.3 2577.8 2617.2 2627.8 134769.0 141661.0 148910.0 152857.0 155347.0 16463.0 16877.7 17067.7 17146.4 17418.8 26248.0 26360.3 26378.5 26425.1 26496.2 11237.2 11248.9 11382.1 11389.8 11601.4 10187.0 10204.3 10360.9 10369.2 10409.1 9971.3 10079.6 10183.8 10478.2 10545.2 2912.5 2921.5 2934.3 2936.8 3034.6 1054.1 1064.1 1080.5 1084.9 1091.9 22595.0 22921.9 23092.5 23125.3 23225.0 1119.2 1122.4 1125.7 1135.5 1142.8 12062.5 12296.4 12487.3 12496.3 12534.7 516229.0 547963.0 554380.0 556139.0 556683.0 124223.0 126551.0 128711.4 129343.0 131561.0 1225.4 1239.1 1264.5 1273.9 1278.1 19252.3 19415.9 19462.4 19471.4 19642.5 63203.0 64267.7 64778.7 66295.7 66861.3 82918.0 83388.0 83744.0 84309.0 84938.6 16334.1 16370.3 16462.8 16496.4 16511.2 25146.2 25476.0 25560.2 25742.6 25840.7 20333.9 20505.1 20596.6 20855.5 20856.2 18118.9 18310.2 18387.4 18471.4 18730.8 20630.2 20669.3 21261.3 21281.8 21377.7 15824.4 16083.2 16089.4 16176.8 16189.3 20097.3 20225.6 20267.4 20288.8 20413.5 12:29:04 INFO - PID 24339 | 12:29:04 INFO - PID 24339 | [#3] mootools.html Cycles:180 Average:10493.44 Median:13734.15 stddev:7573.00 (55.1%) stddev-sans-first:7563.51 12:29:04 INFO - PID 24339 | Values: 1412.1 1457.8 1481.7 1482.7 1495.9 16755.3 17372.7 17395.5 17410.8 17430.9 16942.7 16981.7 17012.5 17016.6 17031.4 2846.0 2906.2 2907.2 2909.3 2909.7 2780.4 2896.6 2897.6 2901.8 2903.9 2826.4 2932.9 2934.0 2934.1 2935.6 2879.1 2898.4 2900.2 2920.8 2944.3 2734.9 2766.8 2770.7 2772.2 2772.5 16373.9 16610.9 16712.6 16745.7 16756.3 8349.6 8562.1 8603.9 8643.6 8667.0 5461.6 5866.2 5930.5 5946.7 6040.5 2080.4 2112.5 2123.4 2163.1 2176.7 29716.4 29929.0 30055.7 30103.7 30127.7 7147.2 7329.6 7333.7 7510.4 7516.3 19252.4 19288.0 19296.1 19306.9 19310.0 8276.1 8804.3 9023.2 9084.1 9097.5 7956.8 7981.1 8028.5 8033.2 8036.8 6012.5 6224.8 6229.9 6256.9 6357.0 1769.4 1846.5 1881.9 1915.0 1947.5 915.2 938.4 939.9 943.3 944.5 9430.9 9805.0 9830.2 9895.6 10133.5 1037.8 1083.8 1090.4 1106.2 1113.0 5571.0 5813.6 5841.5 5939.3 6033.3 23800.5 24250.9 24295.8 24542.5 24733.4 23781.6 24300.0 24424.0 24577.6 24650.5 12772.7 12781.6 12868.4 13086.5 13087.1 9367.2 9499.4 9600.7 9606.3 9698.9 20669.5 21023.6 21500.9 21574.7 21878.9 21524.4 21726.9 22059.0 22405.0 22639.9 13325.9 13481.0 13485.5 13495.7 13500.8 14997.9 15020.8 15040.6 15090.5 15119.2 12335.9 12352.0 12414.8 12669.9 12723.2 12081.9 12192.5 12296.9 12555.1 12670.4 10592.6 10600.3 10696.4 10793.9 10798.7 8072.3 8081.2 8115.2 8237.8 8240.5 8369.0 8376.2 8436.0 8472.8 8575.7 12:29:04 INFO - PID 24339 | 12:29:04 INFO - PID 24339 | [#4] prototype.html Cycles:180 Average:5675.23 Median:6280.85 stddev:1579.07 (25.1%) stddev-sans-first:1535.87 12:29:04 INFO - PID 24339 | Values: 546.7 568.2 576.2 580.2 584.2 6280.9 6309.1 6339.3 6409.5 6464.3 6187.0 6207.3 6220.9 6314.1 6340.9 4944.8 5170.4 5186.9 5193.3 5195.6 4965.7 4998.3 5059.7 5070.9 5074.4 4989.3 5003.3 5007.3 5017.7 5025.7 5003.4 5029.4 5038.1 5048.4 5082.7 4590.2 4596.5 4606.0 4616.6 4622.1 6116.8 6161.6 6251.6 6329.0 6341.1 5925.5 5936.6 5954.8 5961.8 5973.7 6791.6 6804.1 6810.2 6828.4 6830.8 5099.5 5115.7 5145.6 5156.4 5158.3 6769.5 6795.7 6827.0 6980.4 6980.5 5209.9 5227.6 5243.9 5265.4 5277.0 5271.5 5336.8 5340.8 5381.2 5393.5 5865.3 5880.3 5935.8 5936.2 5965.9 6756.0 6792.3 6800.6 6813.0 6828.5 1815.6 1834.7 1835.8 1844.1 1846.4 1209.0 1287.9 1295.4 1300.2 1317.1 6176.2 6180.9 6182.5 6221.5 6318.8 6169.5 6684.6 6744.3 6801.9 6855.2 6008.4 6156.9 6222.6 6228.0 6280.8 3571.3 3575.9 3582.6 3597.7 3610.6 6922.2 6924.8 7042.2 7090.9 7128.2 6905.6 6947.3 6974.8 6978.4 7000.8 6977.8 7041.9 7057.4 7067.6 7081.0 6660.1 6664.8 6668.3 6669.3 6731.5 6670.2 6699.2 6704.4 6716.9 6750.6 7019.7 7057.4 7062.2 7093.6 7098.8 5174.1 5193.8 5202.9 5231.6 5255.3 6615.4 6723.1 6768.5 6780.4 6799.5 6331.8 6537.7 6578.4 6598.3 6684.6 6484.9 6512.3 6594.1 6604.4 6620.4 6476.9 6495.5 6557.0 6560.5 6576.5 6626.6 6666.2 6694.6 6725.4 6739.3 6416.7 6439.2 6451.3 6501.5 6525.5 12:29:04 INFO - PID 24339 | 12:29:04 INFO - PID 24339 | [#5] yui.html Cycles:180 Average:27946.10 Median:17988.96 stddev:42057.24 (233.8%) stddev-sans-first:42126.30 12:29:04 INFO - PID 24339 | Values: 931.9 951.3 981.2 997.6 1010.0 20308.0 20802.9 20831.2 20836.9 20855.1 14413.8 14477.5 14483.3 14531.6 14681.6 1067.6 1092.2 1093.6 1095.0 1095.6 1084.8 1089.1 1091.0 1091.1 1092.9 1086.3 1122.2 1131.3 1131.4 1132.5 1119.2 1120.7 1121.1 1121.7 1122.7 797.6 813.3 820.8 822.4 826.3 19715.4 19795.3 19855.6 19863.0 20011.0 23221.8 23355.2 23802.3 23888.4 23901.5 17982.2 18087.9 18201.8 18264.5 18265.5 3975.0 3986.9 3993.1 4002.5 4003.1 129455.0 159530.2 161071.0 161695.0 165762.0 19002.2 19069.2 19477.5 19629.8 19651.2 34995.1 35460.6 35588.1 35775.8 36057.1 9684.7 9739.8 9860.0 9912.2 9947.1 4673.1 4740.2 4777.5 4791.8 4807.8 6114.1 6154.4 6165.5 6210.8 6248.2 1253.6 1280.1 1303.6 1308.9 1312.6 705.2 707.2 715.1 727.4 733.6 13083.9 13487.4 13780.4 14307.4 14410.9 695.4 716.4 720.6 722.6 736.7 5818.9 5821.7 5912.1 6003.9 6061.4 148412.0 150951.2 151869.0 153614.0 156176.0 130274.0 133171.3 133580.0 133869.0 139667.0 110548.4 110733.4 111025.4 111836.4 112598.0 10977.8 11026.3 11091.3 11111.7 11353.8 53923.6 53959.2 54493.5 54883.5 55444.7 64397.7 65841.7 68518.7 69163.7 69314.0 15698.8 15872.8 16020.5 16093.6 16094.6 17274.4 17595.6 17814.5 17897.6 17995.7 16806.7 16895.7 16933.8 16966.2 17114.7 17361.1 17550.0 17647.2 17672.3 17750.4 18051.2 18189.9 18219.9 18300.8 18418.2 14339.6 14489.3 14503.1 14507.3 14519.3 13496.4 13597.5 13605.4 13620.6 13735.2 12:29:04 INFO - PID 24339 | -------- Summary: end -------- 12:29:04 INFO - PID 24339 | 12:29:05 INFO - TEST-INFO | 24339: exit 0 12:29:05 INFO - TEST-OK | dromaeo_css | took 1108679ms 12:29:05 INFO - TEST-START | kraken 12:29:05 INFO - Initialising browser for kraken test... 12:29:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48650/getInfo.html -profile /tmp/tmpjjcELm/profile 12:29:05 INFO - TEST-INFO | started process 24711 (/builds/slave/test/build/application/firefox/firefox http://localhost:48650/getInfo.html) 12:29:10 INFO - TEST-INFO | 24711: exit 0 12:29:10 INFO - Browser initialized. 12:29:10 INFO - Running cycle 1/1 for kraken test... 12:29:10 INFO - Using env: {'DISPLAY': ':0', 12:29:10 INFO - 'HOME': '/home/cltbld', 12:29:10 INFO - 'JSGC_DISABLE_POISONING': '1', 12:29:10 INFO - 'LANG': 'en_US.UTF-8', 12:29:10 INFO - 'LANGUAGE': 'en_US:en', 12:29:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:29:10 INFO - 'LOGNAME': 'cltbld', 12:29:10 INFO - 'MAIL': '/var/mail/cltbld', 12:29:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:29:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:29:10 INFO - 'MOZ_CRASHREPORTER': '1', 12:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:29:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:29:10 INFO - 'MOZ_NO_REMOTE': '1', 12:29:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:29:10 INFO - 'NO_EM_RESTART': '1', 12:29:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:29:10 INFO - 'PWD': '/builds/slave/test', 12:29:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:29:10 INFO - 'RUST_BACKTRACE': 'full', 12:29:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:29:10 INFO - 'SHELL': '/bin/bash', 12:29:10 INFO - 'SHLVL': '1', 12:29:10 INFO - 'STYLO_FORCE_DISABLED': '1', 12:29:10 INFO - 'TERM': 'linux', 12:29:10 INFO - 'TMOUT': '86400', 12:29:10 INFO - 'USER': 'cltbld', 12:29:10 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597', 12:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:29:10 INFO - '_': '/tools/buildbot/bin/python'} 12:29:10 INFO - TEST-INFO | started process 24952 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjjcELm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:29:11 INFO - PID 24952 | 12:29:11 INFO - PID 24952 | (/builds/slave/test/build/application/firefox/firefox:25001): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:29:11 INFO - PID 24952 | 12:29:21 INFO - PID 24952 | RSS: Main: 144203776 12:29:21 INFO - PID 24952 | 12:29:24 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48650/tests/kraken/driver.html?testName=audio-beat-detection) 12:29:25 INFO - PID 24952 | RSS: Main: 151420928 12:29:25 INFO - PID 24952 | 12:29:27 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48650/tests/kraken/driver.html?testName=audio-dft) 12:29:28 INFO - PID 24952 | RSS: Main: 151687168 12:29:28 INFO - PID 24952 | 12:29:31 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48650/tests/kraken/driver.html?testName=audio-fft) 12:29:32 INFO - PID 24952 | RSS: Main: 147341312 12:29:32 INFO - PID 24952 | 12:29:34 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48650/tests/kraken/driver.html?testName=audio-oscillator) 12:29:34 INFO - PID 24952 | RSS: Main: 148209664 12:29:34 INFO - PID 24952 | 12:29:36 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48650/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:29:37 INFO - PID 24952 | RSS: Main: 148422656 12:29:37 INFO - PID 24952 | 12:29:40 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48650/tests/kraken/driver.html?testName=imaging-darkroom) 12:29:41 INFO - PID 24952 | RSS: Main: 148656128 12:29:41 INFO - PID 24952 | 12:29:44 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48650/tests/kraken/driver.html?testName=imaging-desaturate) 12:29:45 INFO - PID 24952 | RSS: Main: 149549056 12:29:45 INFO - PID 24952 | 12:29:48 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48650/tests/kraken/driver.html?testName=json-parse-financial) 12:29:48 INFO - PID 24952 | RSS: Main: 151117824 12:29:48 INFO - PID 24952 | 12:29:50 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48650/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:29:50 INFO - PID 24952 | RSS: Main: 151027712 12:29:50 INFO - PID 24952 | 12:29:52 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48650/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:29:52 INFO - PID 24952 | RSS: Main: 150945792 12:29:52 INFO - PID 24952 | 12:29:54 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48650/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:29:55 INFO - PID 24952 | RSS: Main: 148127744 12:29:55 INFO - PID 24952 | 12:29:58 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48650/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:29:58 INFO - PID 24952 | RSS: Main: 148164608 12:29:58 INFO - PID 24952 | 12:30:01 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48650/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:30:02 INFO - PID 24952 | RSS: Main: 148246528 12:30:02 INFO - PID 24952 | 12:30:03 INFO - PID 24952 | Cycle 1(1): loaded http://localhost:48650/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48650/tests/kraken/driver.html?testName=ai-astar) 12:30:04 INFO - PID 24952 | RSS: Main: 149635072 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | __start_tp_report 12:30:04 INFO - PID 24952 | _x_x_mozilla_page_load 12:30:04 INFO - PID 24952 | _x_x_mozilla_page_load_details 12:30:04 INFO - PID 24952 | |i|pagename|runs| 12:30:04 INFO - PID 24952 | |0;ai-astar;106;106;106;107;107;111;108;107;105;110 12:30:04 INFO - PID 24952 | |1;audio-beat-detection;125;114;113;112;141;113;142;168;113;118 12:30:04 INFO - PID 24952 | |2;audio-dft;163;165;163;163;164;163;162;163;171;169 12:30:04 INFO - PID 24952 | |3;audio-fft;74;73;75;73;73;74;73;73;78;74 12:30:04 INFO - PID 24952 | |4;audio-oscillator;80;78;78;79;77;78;77;78;78;77 12:30:04 INFO - PID 24952 | |5;imaging-gaussian-blur;114;114;110;113;113;114;114;114;114;117 12:30:04 INFO - PID 24952 | |6;imaging-darkroom;150;150;150;151;151;150;151;151;150;151 12:30:04 INFO - PID 24952 | |7;imaging-desaturate;95;94;94;93;94;93;95;95;95;94 12:30:04 INFO - PID 24952 | |8;json-parse-financial;44;47;43;45;45;44;49;45;44;43 12:30:04 INFO - PID 24952 | |9;json-stringify-tinderbox;39;38;37;37;38;37;37;37;37;38 12:30:04 INFO - PID 24952 | |10;stanford-crypto-aes;74;71;72;72;76;73;74;72;71;74 12:30:04 INFO - PID 24952 | |11;stanford-crypto-ccm;112;108;111;105;109;106;109;108;116;109 12:30:04 INFO - PID 24952 | |12;stanford-crypto-pbkdf2;160;157;153;151;156;153;155;158;149;153 12:30:04 INFO - PID 24952 | |13;stanford-crypto-sha256-iterative;59;60;63;62;59;66;59;62;60;64 12:30:04 INFO - PID 24952 | __end_tp_report 12:30:04 INFO - PID 24952 | __start_cc_report 12:30:04 INFO - PID 24952 | _x_x_mozilla_cycle_collect,702 12:30:04 INFO - PID 24952 | __end_cc_report 12:30:04 INFO - PID 24952 | __startTimestamp1506367804011__endTimestamp 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | ------- Summary: start ------- 12:30:04 INFO - PID 24952 | Number of tests: 14 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#0] ai-astar Cycles:10 Average:107.30 Median:107.00 stddev:1.89 (1.8%) stddev-sans-first:1.94 12:30:04 INFO - PID 24952 | Values: 106.0 106.0 106.0 107.0 107.0 111.0 108.0 107.0 105.0 110.0 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:121.50 stddev:18.73 (15.4%) stddev-sans-first:19.86 12:30:04 INFO - PID 24952 | Values: 125.0 114.0 113.0 112.0 141.0 113.0 142.0 168.0 113.0 118.0 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#2] audio-dft Cycles:10 Average:164.60 Median:163.50 stddev:2.99 (1.8%) stddev-sans-first:3.11 12:30:04 INFO - PID 24952 | Values: 163.0 165.0 163.0 163.0 164.0 163.0 162.0 163.0 171.0 169.0 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#3] audio-fft Cycles:10 Average:74.00 Median:74.00 stddev:1.56 (2.1%) stddev-sans-first:1.66 12:30:04 INFO - PID 24952 | Values: 74.0 73.0 75.0 73.0 73.0 74.0 73.0 73.0 78.0 74.0 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#4] audio-oscillator Cycles:10 Average:78.00 Median:78.00 stddev:0.94 (1.2%) stddev-sans-first:0.67 12:30:04 INFO - PID 24952 | Values: 80.0 78.0 78.0 79.0 77.0 78.0 77.0 78.0 78.0 77.0 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.70 (1.5%) stddev-sans-first:1.80 12:30:04 INFO - PID 24952 | Values: 114.0 114.0 110.0 113.0 113.0 114.0 114.0 114.0 114.0 117.0 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 12:30:04 INFO - PID 24952 | Values: 150.0 150.0 150.0 151.0 151.0 150.0 151.0 151.0 150.0 151.0 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.50 stddev:0.79 (0.8%) stddev-sans-first:0.78 12:30:04 INFO - PID 24952 | Values: 95.0 94.0 94.0 93.0 94.0 93.0 95.0 95.0 95.0 94.0 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#8] json-parse-financial Cycles:10 Average:44.90 Median:45.00 stddev:1.85 (4.1%) stddev-sans-first:1.94 12:30:04 INFO - PID 24952 | Values: 44.0 47.0 43.0 45.0 45.0 44.0 49.0 45.0 44.0 43.0 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#9] json-stringify-tinderbox Cycles:10 Average:37.50 Median:37.50 stddev:0.71 (1.9%) stddev-sans-first:0.50 12:30:04 INFO - PID 24952 | Values: 39.0 38.0 37.0 37.0 38.0 37.0 37.0 37.0 37.0 38.0 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#10] stanford-crypto-aes Cycles:10 Average:72.90 Median:73.50 stddev:1.60 (2.2%) stddev-sans-first:1.64 12:30:04 INFO - PID 24952 | Values: 74.0 71.0 72.0 72.0 76.0 73.0 74.0 72.0 71.0 74.0 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#11] stanford-crypto-ccm Cycles:10 Average:109.30 Median:109.00 stddev:3.13 (2.9%) stddev-sans-first:3.16 12:30:04 INFO - PID 24952 | Values: 112.0 108.0 111.0 105.0 109.0 106.0 109.0 108.0 116.0 109.0 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:155.50 stddev:3.34 (2.1%) stddev-sans-first:2.89 12:30:04 INFO - PID 24952 | Values: 160.0 157.0 153.0 151.0 156.0 153.0 155.0 158.0 149.0 153.0 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.40 Median:62.00 stddev:2.41 (3.9%) stddev-sans-first:2.40 12:30:04 INFO - PID 24952 | Values: 59.0 60.0 63.0 62.0 59.0 66.0 59.0 62.0 60.0 64.0 12:30:04 INFO - PID 24952 | -------- Summary: end -------- 12:30:04 INFO - PID 24952 | 12:30:04 INFO - PID 24952 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:30:04 INFO - TEST-INFO | 24952: exit 0 12:30:04 INFO - TEST-OK | kraken | took 59337ms 12:30:04 INFO - SUITE-END | took 1168s 12:30:04 INFO - Completed test suite (00:19:28) 12:30:04 INFO - javascript benchmark 12:30:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9125.820151424228, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3857.9421308680376, 3888.552816426112, 3896.337622604155, 3905.7851818149998, 3909.1009067914397, 6193.566450348478, 6241.25104987401, 6288.842778930529, 6324.841878953022, 6377.681115944201, 6360.0, 6371.916774148394, 6374.553781235315, 6416.775412860551, 6425.036244563318, 5676.489115979561, 5685.914711279334, 5690.57320700947, 5709.400512946143, 5714.342850572196, 5583.162525621169, 5622.718864056801, 5626.746796394152, 5628.0, 5676.574256930726, 5586.469285417878, 5665.348484924245, 5676.574256930726, 5700.429957004308, 5727.513161381287, 5378.273933019071, 5489.560835133179, 5519.227308176858, 5561.221428999943, 5588.357338906017, 5504.366997795265, 5509.842932984078, 5526.50261476465, 5566.359868615121, 5617.017022021171, 6237.968810155966, 6252.437280644718, 6259.186305780265, 6282.403171698681, 6331.968340158316, 6694.83262918426, 6753.392194702451, 6797.048413222153, 6803.115594972622, 6826.863462730717, 6873.072135261776, 6873.5875847449315, 6875.965620171917, 6876.312368763134, 6885.380315771555, 6361.459275961549, 6386.393292637192, 6396.776112836075, 6435.806925792233, 6445.0, 6935.4104901082965, 6967.79096627102, 7030.613316267552, 7060.293970602898, 7067.787966361017, 6751.358620931003, 6797.422219111431, 6831.487638427038, 6872.381485666314, 6874.2782007889455, 6762.72949082041, 6803.863922721518, 6806.421454176351, 6807.217170025411, 6817.727290908408, 6764.594124352555, 6796.286389928986, 6827.590344579341, 6830.829229269308, 6831.316868313228, 6695.296993815677, 6799.0, 6805.251422343538, 6821.590704557643, 6833.965830170818, 4990.925136122961, 4991.401031876198, 5048.217526283432, 5058.089543882136, 5059.544640982329, 4493.303537951622, 4527.139843429738, 4569.13186494565, 4581.862544123682, 4594.517575654575, 6234.314225435199, 6251.0, 6257.906131408033, 6303.684815759194, 6324.557280990287, 6855.245922948472, 6872.931270687329, 6898.965505172442, 6914.827129321807, 6919.4464442844455, 6232.439080482778, 6244.562880598314, 6313.463355614732, 6323.52573556985, 6370.362963703686, 5456.6725996439545, 5491.615586908878, 5505.889882202334, 5564.638298510584, 5575.804846830422, 7103.183133939559, 7103.325184107502, 7199.496035277585, 7202.027726256993, 7217.097862767154, 6859.142607174103, 6863.0, 6905.136857892763, 6937.7224911002995, 6938.548994315555, 7078.4691148163065, 7090.858182836211, 7103.0, 7202.89195662055, 7205.0, 6660.234073081658, 6735.158105236846, 6747.190337159573, 6769.966150169218, 6770.0, 6747.359000894907, 6757.526973112032, 6767.458603311625, 6770.424513916372, 6774.729010839708, 6570.671466426564, 6594.373534514213, 6653.334666533308, 6659.567128136656, 6676.0, 6588.308227636029, 6619.735210591522, 6622.735090596322, 6693.698783554849, 6709.530332876652, 6420.101185833893, 6495.188101487314, 6508.642024688687, 6516.771912983023, 6603.0, 6653.135092437952, 6692.029655699994, 6718.8320291993095, 6722.361375669304, 6737.393634572912, 6356.237251529846, 6449.0, 6478.060681201106, 6519.282878883414, 6569.605823650596], "value": 6233.576860940789, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [927.2720914082447, 950.7432993091861, 973.9269554783391, 1006.2905651515682, 1008.2236677758126, 41675.0, 42063.57936420635, 42098.368524472084, 42351.0, 42583.14833703328, 42768.57231427693, 43122.35316470255, 43180.568194318046, 43216.78391608038, 43255.35116973248, 8288.171182881724, 8489.66041358345, 8515.95742021289, 8526.190011948886, 8529.701460448885, 8338.583070846464, 8462.026866910292, 8489.575521223915, 8491.830163396728, 8494.235518803307, 8424.073351931283, 8436.662533498684, 8444.704435344764, 8446.450980686266, 8497.575121243945, 8411.242988131067, 8442.366822488277, 8443.662253509852, 8450.239478446938, 8452.450590711614, 7781.805454863617, 7906.130325664172, 7924.009498812648, 7927.207279272026, 7932.920670793276, 39334.60665393338, 39350.80324598359, 39750.0, 39779.80110099431, 39793.0, 3603.8017909014993, 3678.4850120983083, 3701.592824789298, 3705.5368078990127, 3723.4600982857605, 32343.676563234538, 32443.351132977445, 32452.67547324544, 32556.511652325233, 32748.508772368434, 5426.0, 5437.728113594344, 5459.426760190202, 5465.043617366985, 5491.0, 214418.0, 214536.0, 215056.92471537698, 216015.0, 216486.0, 48523.272150917765, 49488.50511494911, 49598.75200623974, 51309.743451282506, 51796.482035179164, 53407.46592534103, 53426.46573534293, 53666.19500707492, 53718.0, 53843.46156538385, 16769.0, 16909.915450422668, 17100.888442251213, 17139.0, 17151.914240428967, 13878.375473103735, 13947.442102315998, 13963.720725585432, 13964.860351396559, 13984.720305593832, 15280.694386112216, 15281.159536225614, 15290.464833730766, 15309.846901530842, 15488.303026363841, 5851.853703657443, 5956.583039187302, 6049.879002419927, 6078.969605151946, 6152.723127459275, 1089.2048804372853, 1095.2552264460244, 1102.5424448853796, 1112.1380929779325, 1118.457548089176, 25389.36526586813, 25416.872915635675, 25463.36341591475, 25562.744372556408, 25606.871965640425, 1210.7672514386609, 1218.287301928364, 1221.8717034711228, 1223.6512593910693, 1239.5475651387178, 13504.122232054886, 13575.0, 13582.524611638546, 13755.587332380044, 13805.654858628615, 271496.0, 272506.0, 272568.0, 290630.0, 293037.0, 58998.410015900154, 59443.0, 59455.702721486115, 59460.0, 59709.104363434584, 1509.562226954193, 1516.2797671106136, 1519.9848001520065, 1523.8095238095239, 1531.364483739258, 30019.249518762204, 30184.396312074074, 30320.090397288117, 30360.240993975327, 30764.846175768977, 39661.60338396579, 39889.0, 39930.60069399269, 39950.0, 40011.999700007735, 222723.0, 223759.0, 223870.0, 224489.0, 225056.0, 35197.944061678194, 35638.465423018155, 35972.4604130933, 36191.638083618825, 36228.09429764277, 43616.0, 44195.77902110469, 44425.55574444344, 44570.55429445664, 44714.3292850601, 32529.837350813094, 32897.34205315928, 33015.17462063468, 33039.50440743439, 33039.83480082584, 32204.516932245566, 32601.510977334885, 32676.183095421853, 32903.506447402826, 32930.0, 37982.0, 38388.232235354575, 38395.80802095972, 38658.42012369761, 38764.22471550497, 31142.221444463165, 31846.0, 31972.0, 32319.838400807846, 32608.0, 24993.250472466752, 25063.373415664755, 25475.235742927744, 25610.743892560837, 25718.485630286916], "value": 18482.947374522548, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.523145788995, 598.6228675934161, 617.8702472480779, 620.7889317632006, 629.6159342800892, 22306.776932230674, 23310.88344558277, 23320.766792332113, 23332.183373581927, 23345.883270583643, 24731.629025564587, 27229.319267018334, 27434.314142146457, 27473.0, 27473.86263068687, 6708.127943367355, 6867.313268673118, 6869.587824730507, 6872.34712702295, 6872.896906546381, 6603.867922641544, 6735.932640673604, 6804.319568043181, 6819.829504262383, 6820.147481564804, 6771.559848609824, 6785.287544807798, 6785.423239024689, 6806.319368063178, 6812.693428795691, 6643.1363922690225, 6794.796156115324, 6799.592024478522, 6818.897716534256, 6877.6217308048035, 6418.679066046726, 6419.390157934989, 6422.389872962061, 6424.100625912376, 6429.967850160766, 31659.20851978719, 31851.52222716661, 31862.362752745048, 32112.0, 32133.357332853448, 2197.4067001909557, 2220.855644383126, 2226.398872304485, 2232.430730163814, 2234.4078819112947, 20246.49383765403, 21142.365729028155, 21190.576188476298, 21206.787932120635, 21225.726456412664, 2538.21315392229, 2560.3343130785943, 2577.80666450017, 2617.175589689242, 2627.8423294602194, 134769.0, 141661.0, 148910.0, 152857.0, 155347.0, 16463.0, 16877.662446750997, 17067.743983840253, 17146.3992561561, 17418.82581174172, 26248.0, 26360.34099147537, 26378.472430551283, 26425.075122370625, 26496.205113846616, 11237.157213209042, 11248.94375528117, 11382.089432845352, 11389.772204555862, 11601.419929003516, 10187.0, 10204.336718113298, 10360.948195259127, 10369.222308326905, 10409.115225205791, 9971.252156088321, 10079.647212347532, 10183.796324073624, 10478.161747060218, 10545.209109316833, 2912.538904625588, 2921.4595299869166, 2934.281101130194, 2936.7797415193945, 3034.620672415948, 1054.093479607537, 1064.1433645914958, 1080.5029686344212, 1084.8860869608577, 1091.912646988239, 22595.0, 22921.885390573272, 23092.53814923692, 23125.306240812803, 23224.954877030574, 1119.1941801902617, 1122.3882983773863, 1125.7129431994788, 1135.4663308245113, 1142.7771584540935, 12062.51749929993, 12296.385180741107, 12487.250764954131, 12496.312702801433, 12534.74930501385, 516229.0, 547963.0, 554380.0, 556139.0, 556683.0, 124223.0, 126551.0, 128711.35644321718, 129343.0, 131561.0, 1225.4240506961892, 1239.1016513027982, 1264.462603393554, 1273.9426725797362, 1278.0606254403006, 19252.326168584033, 19415.90292048587, 19462.416127516197, 19471.4158575243, 19642.50893727668, 63203.0, 64267.67866160639, 64778.67610661917, 66295.66852165708, 66861.33138668552, 82918.0, 83388.0, 83744.0, 84309.0, 84938.57530712555, 16334.101624410772, 16370.263338149574, 16462.83537164613, 16496.42262520806, 16511.174441277646, 25146.24561263165, 25476.0, 25560.23319300424, 25742.613860792477, 25840.741592583832, 20333.89833050825, 20505.077271522518, 20596.588068238852, 20855.478613034797, 20856.165753369696, 18118.909405453414, 18310.176042078405, 18387.448376548724, 18471.445856624323, 18730.812691873452, 20630.17479300811, 20669.276575319793, 21261.255856044965, 21281.829499377684, 21377.67933480968, 15824.44614438489, 16083.195840208176, 16089.356425742839, 16176.757348639545, 16189.271482783068, 20097.296594619118, 20225.59548809045, 20267.391978240677, 20288.797112029282, 20413.48966275855], "value": 13094.2440288672, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1412.1244828206513, 1457.7740450230212, 1481.7240797530783, 1482.6664000599874, 1495.887808414369, 16755.32978680853, 17372.739408908845, 17395.47813565595, 17410.82589174108, 17430.912845435756, 16942.661146777056, 16981.660366792657, 17012.48962531126, 17016.574585635335, 17031.403900863443, 2846.0, 2906.229849089982, 2907.200519857035, 2909.3163106669917, 2909.7381235688786, 2780.3605170810724, 2896.6089577906923, 2897.5943367928508, 2901.7968742188054, 2903.8693258803405, 2826.4488424757183, 2932.8533573321356, 2934.0464349086524, 2934.1344303430433, 2935.6183696119583, 2879.078694817659, 2898.3913378190605, 2900.173450566589, 2920.7517361024234, 2944.263934016496, 2734.9179524614096, 2766.7648249898784, 2770.667519897605, 2772.182206249141, 2772.514809908278, 16373.91813040939, 16610.916945415196, 16712.58218544534, 16745.748813767805, 16756.329746810112, 8349.624266908004, 8562.100979397135, 8603.870941935877, 8643.611037503328, 8667.0, 5461.644993075437, 5866.178734977107, 5930.466258036754, 5946.732397042144, 6040.456358927718, 2080.4278823323557, 2112.535242246703, 2123.3736047865764, 2163.0698799516204, 2176.749673787519, 29716.405671886656, 29928.99999999978, 30055.69944300551, 30103.69896301031, 30127.69872301271, 7147.249538798351, 7329.633518324063, 7333.669984850694, 7510.361619262424, 7516.285952834472, 19252.4224273272, 19288.0, 19296.1316740747, 19306.90346548258, 19310.03449827503, 8276.08963014068, 8804.295656347476, 9023.233025192802, 9084.137006984325, 9097.499637519868, 7956.801079972931, 7981.08217554977, 8028.4781489203015, 8033.156518565466, 8036.799080022929, 6012.549058820606, 6224.813255602339, 6229.937700623026, 6256.906146407808, 6357.0, 1769.4337811900068, 1846.4645252876785, 1881.8682692211414, 1914.9904250478658, 1947.51312171957, 915.2037727177399, 938.3666025432806, 939.8825146856643, 943.2736792669606, 944.5182956691999, 9430.90569094314, 9805.0, 9830.164436023018, 9895.60417583303, 10133.543990520444, 1037.8080055189814, 1083.822213383716, 1090.3730355045723, 1106.164845541611, 1113.0038615439137, 5570.972145139248, 5813.593048486566, 5841.532677385799, 5939.316978547436, 6033.276006879202, 23800.523989520458, 24250.87874560616, 24295.757042429705, 24542.509149817262, 24733.381665458506, 23781.643275350885, 24300.0, 24424.0, 24577.631335529983, 24650.50698986046, 12772.680682983, 12781.61655150347, 12868.356582171042, 13086.476540938445, 13087.149335293176, 9367.203787678123, 9499.38254013487, 9600.711978640651, 9606.327557070937, 9698.9030109698, 20669.483262917947, 21023.579528409653, 21500.89249553742, 21574.676379854, 21878.89060554687, 21524.354269371943, 21726.891365543703, 22059.0, 22405.0, 22639.88680056589, 13325.933370333087, 13481.0, 13485.46058157702, 13495.662608434868, 13500.797488037491, 14997.87515936331, 15020.849791502382, 15040.623984400478, 15090.54728358151, 15119.16844573559, 12335.876641233473, 12352.0, 12414.81377779352, 12669.873301266869, 12723.23660580368, 12081.939590301992, 12192.451339689913, 12296.938515307365, 12555.12114152037, 12670.366481676063, 10592.576296948037, 10600.25798194119, 10696.411697356409, 10793.946030269799, 10798.73003174927, 8072.273495385443, 8081.15147909461, 8115.188481151838, 8237.752867413987, 8240.546769927472, 8369.0, 8376.162383761575, 8436.0, 8472.830543388975, 8575.656973720981], "value": 7444.437217604359, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.7102435709076, 568.2413977340251, 576.1933293389258, 580.1993249315944, 584.2492397269507, 6280.905786413202, 6309.053641953709, 6339.334369891153, 6409.4551963083195, 6464.3212462691445, 6187.0, 6207.255129384469, 6220.875582488347, 6314.1475900753385, 6340.873182536347, 4944.802207911697, 5170.353705786777, 5186.92219616706, 5193.298904647881, 5195.610329225305, 4965.726885021322, 4998.275250088753, 5059.671121377099, 5070.923936140961, 5074.391073071218, 4989.276554899538, 5003.274525193845, 5007.324011258488, 5017.69893806371, 5025.673331233476, 5003.374578177728, 5029.3964724232965, 5038.143515602356, 5048.419431765357, 5082.720450375228, 4590.242609969385, 4596.47140578831, 4605.953940460586, 4616.561426664462, 4622.098690755304, 6116.816495505142, 6161.599496032743, 6251.562390632657, 6328.968470066308, 6341.112244285804, 5925.503952667947, 5936.584439089265, 5954.821355359346, 5961.821145365646, 5973.671448070398, 6791.592504449749, 6804.08144900442, 6810.182778066664, 6828.419584335337, 6830.760923367708, 5099.464556221617, 5115.7442127893455, 5145.562627176694, 5156.355455568054, 5158.277841102249, 6769.458443324522, 6795.694193761293, 6826.965865170741, 6980.441564674814, 6980.546264492792, 5209.921851172159, 5227.60792940531, 5243.9213411798855, 5265.447128051576, 5276.973615131899, 5271.4728527147745, 5336.7865285388925, 5340.8397748066845, 5381.165919282517, 5393.460653934575, 5865.266841644794, 5880.323762767251, 5935.792247271324, 5936.168936348915, 5965.850853728604, 6756.020377045301, 6792.252852186256, 6800.557963732342, 6812.965935170292, 6828.52200345981, 1815.6005678750653, 1834.660587791263, 1835.8072402397822, 1844.124041080476, 1846.3906910719431, 1208.9637310880687, 1287.9484820607258, 1295.3846922711825, 1300.2133709106045, 1317.1109501086728, 6176.197094377702, 6180.8763824723255, 6182.474489668429, 6221.471174950089, 6318.8420289492215, 6169.549870451356, 6684.632345220963, 6744.325567443217, 6801.863962720718, 6855.177378714586, 6008.369121242294, 6156.907646385308, 6222.595531290452, 6227.96886015567, 6280.791869447481, 3571.285782824259, 3575.8748443804343, 3582.570091589026, 3597.712183025352, 3610.6389361063684, 6922.203946546211, 6924.826879328057, 7042.190148133031, 7090.893636595455, 7128.215896251409, 6905.585664860125, 6947.270536593686, 6974.755883544051, 6978.3831063351245, 7000.789976300719, 6977.79066628002, 7041.859162816715, 7057.435405167575, 7067.57594544329, 7081.0, 6660.134182556237, 6664.8000559983275, 6668.299828517936, 6669.266380698216, 6731.4951378647775, 6670.199576050905, 6699.196096468455, 6704.363085506869, 6716.899246511404, 6750.628715420503, 7019.684114214975, 7057.435405167677, 7062.15254169503, 7093.574385536885, 7098.822529436806, 5174.120399532013, 5193.75349916025, 5202.947970520398, 5231.581473482036, 5255.264263003259, 6615.437687796399, 6723.125993620798, 6768.4585233182215, 6780.372710549531, 6799.524033317818, 6331.841703957438, 6537.673116344069, 6578.407943285128, 6598.307177746459, 6684.598924064571, 6484.935150648433, 6512.3017359810165, 6594.142761441174, 6604.447954730538, 6620.437262832713, 6476.902846457213, 6495.480361570969, 6556.967340124576, 6560.507961902781, 6576.473882089325, 6626.635535045619, 6666.233448136345, 6694.59832410057, 6725.43551917465, 6739.326067393417, 6416.679166041586, 6439.162908822011, 6451.322656109352, 6501.51238657112, 6525.477961762953], "value": 5221.024885227082, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [931.9161275485205, 951.3103000324766, 981.1513041219346, 997.6258902911409, 1009.9545520451579, 20308.0, 20802.895985520052, 20831.166753329868, 20836.89581552094, 20855.061522231517, 14413.783793243083, 14477.493287734906, 14483.275836208173, 14531.564053078424, 14681.559553213394, 1067.6423398161626, 1092.180864351736, 1093.6008356949696, 1094.9726256843562, 1095.5508241620937, 1084.8426978088173, 1089.0797276301512, 1090.9618163364244, 1091.0671375973548, 1092.9180311476632, 1086.2504871638585, 1122.2480937771672, 1131.3042478875473, 1131.3664347965125, 1132.4620805117545, 1119.1829964126152, 1120.6918097523164, 1121.058311018744, 1121.7476067884702, 1122.6632010396847, 797.5812698333364, 813.2721214512977, 820.8358328334357, 822.440740296598, 826.2563692676579, 19715.40853774389, 19795.30716424918, 19855.602887942303, 19863.0, 20011.0, 23221.76778232213, 23355.182568610016, 23802.285931422084, 23888.402789930216, 23901.521969560687, 17982.190801413835, 18087.909560452114, 18201.817981820277, 18264.45206643803, 18265.45203643893, 3975.0062484378905, 3986.920261594781, 3993.0815912340327, 4002.5397079335667, 4003.1393250451, 129455.0, 159530.2023489875, 161071.0, 161695.0, 165762.0, 19002.23991040343, 19069.237230510626, 19477.513062173275, 19629.8037019628, 19651.213951442067, 34995.12512187165, 35460.64539354625, 35588.110297242776, 35775.82112089423, 36057.0985725359, 9684.661036863676, 9739.756506087404, 9859.950700246452, 9912.207023438108, 9947.10476057144, 4673.112108699336, 4740.2178640523925, 4777.522247775264, 4791.808327666854, 4807.807687692453, 6114.052321890114, 6154.3845615438995, 6165.5375846810775, 6210.813675589739, 6248.156498872685, 1253.6239128261484, 1280.1231156657534, 1303.6284658872175, 1308.8756568126014, 1312.645585691877, 705.1925545250659, 707.2079271216271, 715.0954043135438, 727.3998950865557, 733.6185183704443, 13083.934580327037, 13487.393067311994, 13780.379882905294, 14307.356168972421, 14410.855891440951, 695.391532409142, 716.3946465236867, 720.5712601002396, 722.5664601239214, 736.6942718771757, 5818.94181058184, 5821.650700957956, 5912.083627037816, 6003.879922401527, 6061.424164704346, 148412.0, 150951.24524377307, 151869.0, 153614.0, 156176.0, 130274.0, 133171.33414332866, 133580.0, 133869.0, 139667.0, 110548.4472577632, 110733.44633276942, 111025.44487277512, 111836.44081779702, 112598.0, 10977.780444390908, 11026.338419694845, 11091.33451992883, 11111.666650000512, 11353.772924541297, 53923.573439196116, 53959.19061214006, 54493.45506545043, 54883.45116548943, 55444.72277638586, 64397.67801161152, 65841.67079164574, 68518.65740671464, 69163.65418172877, 69314.0, 15698.843011569737, 15872.76190857115, 16020.519384418487, 16093.597660058593, 16094.597635059217, 17274.395396161075, 17595.56011099733, 17814.46556603304, 17897.552561186076, 17995.73006404879, 16806.747898781283, 16895.66208675795, 16933.830661693224, 16966.236519356906, 17114.657706846043, 17361.131943402528, 17550.0, 17647.20587573588, 17672.293108275524, 17750.378736744668, 18051.18769655395, 18189.909050454662, 18219.908900455943, 18300.790191277913, 18418.17118229656, 14339.569812905629, 14489.347979340744, 14503.1298122113, 14507.274636268356, 14519.274036298355, 13496.392662330023, 13597.456101755819, 13605.387757550736, 13620.591382258548, 13735.175889446666], "value": 9849.822873993553, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1388.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 106.0, 106.0, 107.0, 107.0, 111.0, 108.0, 107.0, 105.0, 110.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 114.0, 113.0, 112.0, 141.0, 113.0, 142.0, 168.0, 113.0, 118.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 163.0, 164.0, 163.0, 162.0, 163.0, 171.0, 169.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 73.0, 73.0, 74.0, 73.0, 73.0, 78.0, 74.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 78.0, 79.0, 77.0, 78.0, 77.0, 78.0, 78.0, 77.0], "value": 78.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 110.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 117.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 151.0, 151.0, 150.0, 151.0, 151.0, 150.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 93.0, 94.0, 93.0, 95.0, 95.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 47.0, 43.0, 45.0, 45.0, 44.0, 49.0, 45.0, 44.0, 43.0], "value": 44.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 37.0, 37.0, 38.0, 37.0, 37.0, 37.0, 37.0, 38.0], "value": 37.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 72.0, 72.0, 76.0, 73.0, 74.0, 72.0, 71.0, 74.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 111.0, 105.0, 109.0, 106.0, 109.0, 108.0, 116.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 157.0, 153.0, 151.0, 156.0, 153.0, 155.0, 158.0, 149.0, 153.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 63.0, 62.0, 59.0, 66.0, 59.0, 62.0, 60.0, 64.0], "value": 61.4, "unit": "score"}]}]} 12:30:04 INFO - Return code: 0 12:30:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:30:04 INFO - # TBPL SUCCESS # 12:30:04 INFO - Running post-action listener: _package_coverage_data 12:30:04 INFO - Running post-action listener: _resource_record_post_action 12:30:04 INFO - [mozharness: 2017-09-25 19:30:04.798741Z] Finished run-tests step (success) 12:30:04 INFO - Running post-run listener: _resource_record_post_run 12:30:04 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 329592832; Read time: 16; Write time: 297100 12:30:04 INFO - TinderboxPrint: CPU usage
13.1% 12:30:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:30:04 INFO - TinderboxPrint: I/O write bytes / time
329,592,832 / 297,100 12:30:04 INFO - TinderboxPrint: CPU idle
8,217.9 (86.9%) 12:30:04 INFO - TinderboxPrint: CPU user
1,187.3 (12.6%) 12:30:04 INFO - TinderboxPrint: Swap in / out
0 / 0 12:30:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12603392; Read time: 0; Write time: 2316 12:30:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:30:04 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 4096; Write bytes: 315867136; Read time: 16; Write time: 294752 12:30:05 INFO - Running post-run listener: _upload_blobber_files 12:30:05 INFO - Blob upload gear active. 12:30:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:30:05 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 12:30:05 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'] 12:30:05 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 12:30:05 INFO - (blobuploader) - INFO - Open directory for files ... 12:30:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:30:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:30:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:30:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:30:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:30:06 INFO - (blobuploader) - INFO - Done attempting. 12:30:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:30:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:30:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:30:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:30:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:30:15 INFO - (blobuploader) - INFO - Done attempting. 12:30:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 12:30:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:30:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:30:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 12:30:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:30:15 INFO - (blobuploader) - INFO - Done attempting. 12:30:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 12:30:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:30:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:30:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 12:30:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:30:17 INFO - (blobuploader) - INFO - Done attempting. 12:30:17 INFO - (blobuploader) - INFO - Iteration through files over. 12:30:17 INFO - Return code: 0 12:30:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:30:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:30:17 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c9ec570ffde1ba6c9ec8fba13c9f1d3c63aa40e99b3bf3c9953d4dda570feeb6f1873e6a117b39537df1f1144829d7b9fd2f57dba853c4a10bb78e6d99763d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b053d8b5ec99f6f2b8f224cf67a87ba1eaa9bf3891b178528b5e100b6d9d43ebdc78484bbc20032b1f950e77d9f6fe21b85dbd42365f5b5a0a799b8483b3c9bd", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e93549f6f51432ae91bc08b53fe01bf8917dfd5ef5eef03c9e015d1aef28e8be524c76cd79f3d7a5705911d971a85f5369ebc86e1c038819ba1891d64ae13ffd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c347445fbcf5e3812426b65efc9f0c611062cf32e7d382f07e738cb198e87b35f23613f41a85a3e2a5d5f38ca938cfd0c7b59f8c2a48556d0e6e469b30deae1"} 12:30:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:30:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:30:17 INFO - Contents: 12:30:17 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c9ec570ffde1ba6c9ec8fba13c9f1d3c63aa40e99b3bf3c9953d4dda570feeb6f1873e6a117b39537df1f1144829d7b9fd2f57dba853c4a10bb78e6d99763d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b053d8b5ec99f6f2b8f224cf67a87ba1eaa9bf3891b178528b5e100b6d9d43ebdc78484bbc20032b1f950e77d9f6fe21b85dbd42365f5b5a0a799b8483b3c9bd", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e93549f6f51432ae91bc08b53fe01bf8917dfd5ef5eef03c9e015d1aef28e8be524c76cd79f3d7a5705911d971a85f5369ebc86e1c038819ba1891d64ae13ffd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c347445fbcf5e3812426b65efc9f0c611062cf32e7d382f07e738cb198e87b35f23613f41a85a3e2a5d5f38ca938cfd0c7b59f8c2a48556d0e6e469b30deae1"} 12:30:17 INFO - Running post-run listener: copy_logs_to_upload_dir 12:30:17 INFO - Copying logs to upload dir... 12:30:17 INFO - mkdir: /builds/slave/test/build/upload/logs 12:30:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.908943 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-09-25 12:30:17.887747) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 12:30:17.892376) ========= 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=2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c9ec570ffde1ba6c9ec8fba13c9f1d3c63aa40e99b3bf3c9953d4dda570feeb6f1873e6a117b39537df1f1144829d7b9fd2f57dba853c4a10bb78e6d99763d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b053d8b5ec99f6f2b8f224cf67a87ba1eaa9bf3891b178528b5e100b6d9d43ebdc78484bbc20032b1f950e77d9f6fe21b85dbd42365f5b5a0a799b8483b3c9bd", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e93549f6f51432ae91bc08b53fe01bf8917dfd5ef5eef03c9e015d1aef28e8be524c76cd79f3d7a5705911d971a85f5369ebc86e1c038819ba1891d64ae13ffd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c347445fbcf5e3812426b65efc9f0c611062cf32e7d382f07e738cb198e87b35f23613f41a85a3e2a5d5f38ca938cfd0c7b59f8c2a48556d0e6e469b30deae1"} build_url:https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011487 build_url: 'https://queue.taskcluster.net/v1/task/NWLEEd7oRfGpMvp2N6mJHQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c9ec570ffde1ba6c9ec8fba13c9f1d3c63aa40e99b3bf3c9953d4dda570feeb6f1873e6a117b39537df1f1144829d7b9fd2f57dba853c4a10bb78e6d99763d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b053d8b5ec99f6f2b8f224cf67a87ba1eaa9bf3891b178528b5e100b6d9d43ebdc78484bbc20032b1f950e77d9f6fe21b85dbd42365f5b5a0a799b8483b3c9bd", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e93549f6f51432ae91bc08b53fe01bf8917dfd5ef5eef03c9e015d1aef28e8be524c76cd79f3d7a5705911d971a85f5369ebc86e1c038819ba1891d64ae13ffd", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c347445fbcf5e3812426b65efc9f0c611062cf32e7d382f07e738cb198e87b35f23613f41a85a3e2a5d5f38ca938cfd0c7b59f8c2a48556d0e6e469b30deae1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-25 12:30:17.923924) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 12:30:17.924269) ========= 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=2432103b8b3de4003b23cad4000001c2-1506366578.953706-1965736597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-25 12:30:18.010159) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 12:30:18.010564) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-25 12:30:18.011008) ========= ========= Total master_lag: 0.22 =========