builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1501621642.79 results: success (0) revision: a3e675a3b10a0ea289c301bedc31866f3daf7875 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:22.785430) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:22.785948) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:22.786276) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:22.802522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:22.802960) ========= 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=db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-01 14:07:22-- 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% 69.4M=0s 2017-08-01 14:07:22 (69.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134473 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:22.958032) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:22.958421) ========= 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=db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021251 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:23.012083) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:23.012589) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a3e675a3b10a0ea289c301bedc31866f3daf7875 --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 a3e675a3b10a0ea289c301bedc31866f3daf7875 --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=db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-01 14:07:23,054 truncating revision to first 12 chars 2017-08-01 14:07:23,054 Setting DEBUG logging. 2017-08-01 14:07:23,054 attempt 1/10 2017-08-01 14:07:23,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a3e675a3b10a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-01 14:07:23,517 unpacking tar archive at: mozilla-central-a3e675a3b10a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.833574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:23.862948) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:23.863530) ========= script_repo_revision: a3e675a3b10a0ea289c301bedc31866f3daf7875 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:23.864030) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:23.866659) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 14:07:23.877882) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-01 14:07:23.878336) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:07:24 INFO - MultiFileLogger online at 20170801 14:07:24 in /builds/slave/test 14:07:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:07:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:07:24 INFO - {'append_to_log': False, 14:07:24 INFO - 'base_work_dir': '/builds/slave/test', 14:07:24 INFO - 'blob_upload_branch': 'Firefox', 14:07:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:07:24 INFO - 'branch': 'Firefox', 14:07:24 INFO - 'buildbot_json_path': 'buildprops.json', 14:07:24 INFO - 'code_coverage': False, 14:07:24 INFO - 'config_files': ('talos/linux_config.py',), 14:07:24 INFO - 'default_actions': ('clobber', 14:07:24 INFO - 'read-buildbot-config', 14:07:24 INFO - 'download-and-extract', 14:07:24 INFO - 'populate-webroot', 14:07:24 INFO - 'create-virtualenv', 14:07:24 INFO - 'install', 14:07:24 INFO - 'setup-mitmproxy', 14:07:24 INFO - 'run-tests'), 14:07:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:07:24 INFO - 'disable_ccov_upload': False, 14:07:24 INFO - 'download_minidump_stackwalk': True, 14:07:24 INFO - 'download_symbols': 'ondemand', 14:07:24 INFO - 'enable_stylo': False, 14:07:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:07:24 INFO - 'tooltool.py': '/tools/tooltool.py', 14:07:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:07:24 INFO - '/tools/misc-python/virtualenv.py')}, 14:07:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:07:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:07:24 INFO - 'gecko_profile': False, 14:07:24 INFO - 'gecko_profile_interval': 0, 14:07:24 INFO - 'installer_path': 'installer.exe', 14:07:24 INFO - 'log_level': 'info', 14:07:24 INFO - 'log_name': 'talos', 14:07:24 INFO - 'log_to_console': True, 14:07:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:07:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:07:24 INFO - 'opt_config_files': (), 14:07:24 INFO - 'pip_index': False, 14:07:24 INFO - 'suite': 'dromaeojs-e10s', 14:07:24 INFO - 'system_bits': '32', 14:07:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:07:24 INFO - 'title': 'talos-linux64-ix-031', 14:07:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:07:24 INFO - 'use_talos_json': True, 14:07:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:07:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:07:24 INFO - 'work_dir': 'build'} 14:07:24 INFO - [mozharness: 2017-08-01 21:07:24.030032Z] Running clobber step. 14:07:24 INFO - Running pre-action listener: _resource_record_pre_action 14:07:24 INFO - Running main action method: clobber 14:07:24 INFO - rmtree: /builds/slave/test/build 14:07:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:07:25 INFO - Running post-action listener: _resource_record_post_action 14:07:25 INFO - [mozharness: 2017-08-01 21:07:25.065812Z] Finished clobber step (success) 14:07:25 INFO - [mozharness: 2017-08-01 21:07:25.065913Z] Running read-buildbot-config step. 14:07:25 INFO - Running pre-action listener: _resource_record_pre_action 14:07:25 INFO - Running main action method: read_buildbot_config 14:07:25 INFO - Using buildbot properties: 14:07:25 INFO - { 14:07:25 INFO - "project": "", 14:07:25 INFO - "product": "firefox", 14:07:25 INFO - "who": "kwierso@gmail.com", 14:07:25 INFO - "installer_path": "public/build/target.tar.bz2", 14:07:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 14:07:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:07:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 14:07:25 INFO - "stage_platform": "linux64-stylosequential", 14:07:25 INFO - "basedir": "/builds/slave/test", 14:07:25 INFO - "buildnumber": 13, 14:07:25 INFO - "platform": "ubuntu64_hw_styloseq", 14:07:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:07:25 INFO - "slavebuilddir": "test", 14:07:25 INFO - "taskId": "Tt8SpyjvTfGNjr55AxgvRw", 14:07:25 INFO - "branch": "mozilla-central", 14:07:25 INFO - "script_repo_revision": "production", 14:07:25 INFO - "revision": "a3e675a3b10a0ea289c301bedc31866f3daf7875", 14:07:25 INFO - "slavename": "talos-linux64-ix-031", 14:07:25 INFO - "repo_path": "mozilla-central" 14:07:25 INFO - } 14:07:25 INFO - Finding installer, test and symbols from parent task. 14:07:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tt8SpyjvTfGNjr55AxgvRw'}, attempt #1 14:07:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tt8SpyjvTfGNjr55AxgvRw'}, attempt #1 14:07:25 INFO - Task dependencies: Q3D2GEEATdOj72Ov3q5KTg 14:07:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg'}, attempt #1 14:07:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2 14:07:26 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.test_packages.json 14:07:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.crashreporter-symbols.zip 14:07:26 INFO - Running post-action listener: _resource_record_post_action 14:07:26 INFO - [mozharness: 2017-08-01 21:07:26.414826Z] Finished read-buildbot-config step (success) 14:07:26 INFO - [mozharness: 2017-08-01 21:07:26.415048Z] Running download-and-extract step. 14:07:26 INFO - Running pre-action listener: _resource_record_pre_action 14:07:26 INFO - Running main action method: download_and_extract 14:07:26 INFO - mkdir: /builds/slave/test/build/tests 14:07:26 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')]} 14:07:26 INFO - trying https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.test_packages.json 14:07:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:07:26 INFO - Downloaded 989 bytes. 14:07:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:07:26 INFO - Using the following test package requirements: 14:07:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:07:26 INFO - u'common': [u'target.common.tests.zip'], 14:07:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:07:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:07:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:07:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:07:26 INFO - u'mozbase': [u'target.common.tests.zip'], 14:07:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:07:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:07:26 INFO - u'web-platform': [u'target.common.tests.zip', 14:07:26 INFO - u'target.web-platform.tests.tar.gz'], 14:07:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:07:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:07:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.common.tests.zip 14:07:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:07:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.common.tests.zip into memory 14:07:28 INFO - Content-Length response header: 72390510 14:07:28 INFO - Bytes received: 72390510 14:07:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:07:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.common.tests.zip 14:07:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:07:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.common.tests.zip into memory 14:07:40 INFO - Content-Length response header: 72390510 14:07:40 INFO - Bytes received: 72390510 14:07:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.talos.tests.zip 14:07:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:07:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.talos.tests.zip into memory 14:07:53 INFO - Content-Length response header: 14496467 14:07:53 INFO - Bytes received: 14496467 14:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:53 INFO - trying https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2 14:07:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:07:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:07:54 INFO - Downloaded 62159884 bytes. 14:07:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2 14:07:54 INFO - mkdir: /builds/slave/test/properties 14:07:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:07:54 INFO - Writing to file /builds/slave/test/properties/build_url 14:07:54 INFO - Contents: 14:07:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2 14:07:54 INFO - Running post-action listener: _resource_record_post_action 14:07:54 INFO - Running post-action listener: set_extra_try_arguments 14:07:54 INFO - [mozharness: 2017-08-01 21:07:54.702045Z] Finished download-and-extract step (success) 14:07:54 INFO - [mozharness: 2017-08-01 21:07:54.702143Z] Running populate-webroot step. 14:07:54 INFO - Running pre-action listener: _resource_record_pre_action 14:07:54 INFO - Running main action method: populate_webroot 14:07:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:07:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:07:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:07:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:07:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:07:54 INFO - 'tests': ['damp', 'tps']}, 14:07:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:07:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:07:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:07:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:07:54 INFO - 'other-e10s': {'tests': ['a11yr', 14:07:54 INFO - 'ts_paint', 14:07:54 INFO - 'tpaint', 14:07:54 INFO - 'sessionrestore', 14:07:54 INFO - 'sessionrestore_many_windows', 14:07:54 INFO - 'sessionrestore_no_auto_restore', 14:07:54 INFO - 'tabpaint']}, 14:07:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:07:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 14:07:54 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:07:54 INFO - 'talos_options': ['--mitmproxy', 14:07:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:07:54 INFO - '--firstNonBlankPaint'], 14:07:54 INFO - 'tests': ['quantum_pageload_google', 14:07:54 INFO - 'quantum_pageload_youtube', 14:07:54 INFO - 'quantum_pageload_amazon', 14:07:54 INFO - 'quantum_pageload_facebook']}, 14:07:54 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:07:54 INFO - 'talos_options': ['--stylo', 14:07:54 INFO - '--mitmproxy', 14:07:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:07:54 INFO - '--firstNonBlankPaint'], 14:07:54 INFO - 'tests': ['quantum_pageload_google', 14:07:54 INFO - 'quantum_pageload_youtube', 14:07:54 INFO - 'quantum_pageload_amazon', 14:07:54 INFO - 'quantum_pageload_facebook']}, 14:07:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:07:54 INFO - 'tsvgr_opacity', 14:07:54 INFO - 'tart', 14:07:54 INFO - 'tscrollx', 14:07:54 INFO - 'cart', 14:07:54 INFO - 'tsvg_static']}, 14:07:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:07:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:07:54 INFO - 'talos_options': ['--stylo', 14:07:54 INFO - '--stylo-threads=1', 14:07:54 INFO - '--mitmproxy', 14:07:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:07:54 INFO - '--firstNonBlankPaint'], 14:07:54 INFO - 'tests': ['tp6_google', 14:07:54 INFO - 'tp6_youtube', 14:07:54 INFO - 'tp6_amazon', 14:07:54 INFO - 'tp6_facebook']}, 14:07:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:07:54 INFO - 'talos_options': ['--xperf_path', 14:07:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:07:54 INFO - 'tests': ['tp5n']}}} 14:07:54 INFO - Running post-action listener: _resource_record_post_action 14:07:54 INFO - [mozharness: 2017-08-01 21:07:54.710766Z] Finished populate-webroot step (success) 14:07:54 INFO - [mozharness: 2017-08-01 21:07:54.710858Z] Running create-virtualenv step. 14:07:54 INFO - Running pre-action listener: _resource_record_pre_action 14:07:54 INFO - Running main action method: create_virtualenv 14:07:54 INFO - Creating virtualenv /builds/slave/test/build/venv 14:07:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:07:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:07:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:07:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:07:54 INFO - Using real prefix '/usr' 14:07:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:07:55 INFO - Installing distribute.............................................................................................................................................................................................done. 14:07:57 INFO - Installing pip.................done. 14:07:57 INFO - Return code: 0 14:07:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:07:57 INFO - Reading from file tmpfile_stdout 14:07:57 INFO - Output received: 14:07:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:07:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c5eb0>, '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 0x26c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c7240>, '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': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', '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 14:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:07:57 INFO - Using env: {'DISPLAY': ':0', 14:07:57 INFO - 'HOME': '/home/cltbld', 14:07:57 INFO - 'LANG': 'en_US.UTF-8', 14:07:57 INFO - 'LANGUAGE': 'en_US:en', 14:07:57 INFO - 'LOGNAME': 'cltbld', 14:07:57 INFO - 'MAIL': '/var/mail/cltbld', 14:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:57 INFO - 'MOZ_NO_REMOTE': '1', 14:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:57 INFO - 'NO_EM_RESTART': '1', 14:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:57 INFO - 'PWD': '/builds/slave/test', 14:07:57 INFO - 'SHELL': '/bin/bash', 14:07:57 INFO - 'SHLVL': '1', 14:07:57 INFO - 'TERM': 'linux', 14:07:57 INFO - 'TMOUT': '86400', 14:07:57 INFO - 'USER': 'cltbld', 14:07:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', 14:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:57 INFO - '_': '/tools/buildbot/bin/python'} 14:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:07:57 INFO - Cleaning up... 14:07:57 INFO - Return code: 0 14:07:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c5eb0>, '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 0x26c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c7240>, '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': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', '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 14:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:07:57 INFO - Using env: {'DISPLAY': ':0', 14:07:57 INFO - 'HOME': '/home/cltbld', 14:07:57 INFO - 'LANG': 'en_US.UTF-8', 14:07:57 INFO - 'LANGUAGE': 'en_US:en', 14:07:57 INFO - 'LOGNAME': 'cltbld', 14:07:57 INFO - 'MAIL': '/var/mail/cltbld', 14:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:57 INFO - 'MOZ_NO_REMOTE': '1', 14:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:57 INFO - 'NO_EM_RESTART': '1', 14:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:57 INFO - 'PWD': '/builds/slave/test', 14:07:57 INFO - 'SHELL': '/bin/bash', 14:07:57 INFO - 'SHLVL': '1', 14:07:57 INFO - 'TERM': 'linux', 14:07:57 INFO - 'TMOUT': '86400', 14:07:57 INFO - 'USER': 'cltbld', 14:07:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', 14:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:57 INFO - '_': '/tools/buildbot/bin/python'} 14:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:07:58 INFO - Downloading/unpacking psutil>=3.1.1 14:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:07:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:07:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:07:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:59 INFO - Installing collected packages: psutil 14:07:59 INFO - Running setup.py install for psutil 14:07:59 INFO - building 'psutil._psutil_linux' extension 14:07:59 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 14:07:59 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 14:07:59 INFO - building 'psutil._psutil_posix' extension 14:07:59 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 14:07:59 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 14:07:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:07:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:07:59 INFO - Successfully installed psutil 14:07:59 INFO - Cleaning up... 14:07:59 INFO - Return code: 0 14:07:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:07: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')]} 14:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:07: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')]} 14:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:07: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c5eb0>, '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 0x26c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c7240>, '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': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', '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 14:07: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:07: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 mozsystemmonitor==0.3 14:07:59 INFO - Using env: {'DISPLAY': ':0', 14:07:59 INFO - 'HOME': '/home/cltbld', 14:07:59 INFO - 'LANG': 'en_US.UTF-8', 14:07:59 INFO - 'LANGUAGE': 'en_US:en', 14:07:59 INFO - 'LOGNAME': 'cltbld', 14:07:59 INFO - 'MAIL': '/var/mail/cltbld', 14:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:59 INFO - 'MOZ_NO_REMOTE': '1', 14:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:07:59 INFO - 'NO_EM_RESTART': '1', 14:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:59 INFO - 'PWD': '/builds/slave/test', 14:07:59 INFO - 'SHELL': '/bin/bash', 14:07:59 INFO - 'SHLVL': '1', 14:07:59 INFO - 'TERM': 'linux', 14:07:59 INFO - 'TMOUT': '86400', 14:07:59 INFO - 'USER': 'cltbld', 14:07:59 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', 14:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:59 INFO - '_': '/tools/buildbot/bin/python'} 14:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:08: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 14:08: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 14:08: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 14:08: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 14:08:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:08:01 INFO - Installing collected packages: mozsystemmonitor 14:08:01 INFO - Running setup.py install for mozsystemmonitor 14:08:01 INFO - Successfully installed mozsystemmonitor 14:08:01 INFO - Cleaning up... 14:08:01 INFO - Return code: 0 14:08:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c5eb0>, '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 0x26c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c7240>, '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': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', '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 14:08:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:08:01 INFO - Using env: {'DISPLAY': ':0', 14:08:01 INFO - 'HOME': '/home/cltbld', 14:08:01 INFO - 'LANG': 'en_US.UTF-8', 14:08:01 INFO - 'LANGUAGE': 'en_US:en', 14:08:01 INFO - 'LOGNAME': 'cltbld', 14:08:01 INFO - 'MAIL': '/var/mail/cltbld', 14:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:01 INFO - 'MOZ_NO_REMOTE': '1', 14:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:01 INFO - 'NO_EM_RESTART': '1', 14:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:01 INFO - 'PWD': '/builds/slave/test', 14:08:01 INFO - 'SHELL': '/bin/bash', 14:08:01 INFO - 'SHLVL': '1', 14:08:01 INFO - 'TERM': 'linux', 14:08:01 INFO - 'TMOUT': '86400', 14:08:01 INFO - 'USER': 'cltbld', 14:08:01 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', 14:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:01 INFO - '_': '/tools/buildbot/bin/python'} 14:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:01 INFO - Downloading/unpacking jsonschema==2.5.1 14:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:08:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:08: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 14:08: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 14:08: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 14:08: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 14:08:02 INFO - Downloading functools32-3.2.3-2.tar.gz 14:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:08:02 INFO - warning: no files found matching '*.txt' 14:08:02 INFO - no previously-included directories found matching 'build' 14:08:02 INFO - no previously-included directories found matching 'dist' 14:08:02 INFO - no previously-included directories found matching '.git*' 14:08:02 INFO - Installing collected packages: jsonschema, functools32 14:08:02 INFO - Running setup.py install for functools32 14:08:02 INFO - warning: no files found matching '*.txt' 14:08:02 INFO - no previously-included directories found matching 'build' 14:08:02 INFO - no previously-included directories found matching 'dist' 14:08:02 INFO - no previously-included directories found matching '.git*' 14:08:02 INFO - Successfully installed jsonschema functools32 14:08:02 INFO - Cleaning up... 14:08:02 INFO - Return code: 0 14:08:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:08: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')]} 14:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08: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')]} 14:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08: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', '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 0x23591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c5eb0>, '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 0x26c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c7240>, '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': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', '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 14:08: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:08: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 functools32==3.2.3-2 14:08:02 INFO - Using env: {'DISPLAY': ':0', 14:08:02 INFO - 'HOME': '/home/cltbld', 14:08:02 INFO - 'LANG': 'en_US.UTF-8', 14:08:02 INFO - 'LANGUAGE': 'en_US:en', 14:08:02 INFO - 'LOGNAME': 'cltbld', 14:08:02 INFO - 'MAIL': '/var/mail/cltbld', 14:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:02 INFO - 'MOZ_NO_REMOTE': '1', 14:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:02 INFO - 'NO_EM_RESTART': '1', 14:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:02 INFO - 'PWD': '/builds/slave/test', 14:08:02 INFO - 'SHELL': '/bin/bash', 14:08:02 INFO - 'SHLVL': '1', 14:08:02 INFO - 'TERM': 'linux', 14:08:02 INFO - 'TMOUT': '86400', 14:08:02 INFO - 'USER': 'cltbld', 14:08:02 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', 14:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:02 INFO - '_': '/tools/buildbot/bin/python'} 14:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:08:03 INFO - Cleaning up... 14:08:03 INFO - Return code: 0 14:08:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:08:03 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')]} 14:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:03 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')]} 14:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:03 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 0x23591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c5eb0>, '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 0x26c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c7240>, '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': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', '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 14:08:03 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 14:08:03 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 14:08:03 INFO - Using env: {'DISPLAY': ':0', 14:08:03 INFO - 'HOME': '/home/cltbld', 14:08:03 INFO - 'LANG': 'en_US.UTF-8', 14:08:03 INFO - 'LANGUAGE': 'en_US:en', 14:08:03 INFO - 'LOGNAME': 'cltbld', 14:08:03 INFO - 'MAIL': '/var/mail/cltbld', 14:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:03 INFO - 'MOZ_NO_REMOTE': '1', 14:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:03 INFO - 'NO_EM_RESTART': '1', 14:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:03 INFO - 'PWD': '/builds/slave/test', 14:08:03 INFO - 'SHELL': '/bin/bash', 14:08:03 INFO - 'SHLVL': '1', 14:08:03 INFO - 'TERM': 'linux', 14:08:03 INFO - 'TMOUT': '86400', 14:08:03 INFO - 'USER': 'cltbld', 14:08:03 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', 14:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:03 INFO - '_': '/tools/buildbot/bin/python'} 14:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:03 INFO - Downloading/unpacking blobuploader==1.2.4 14:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:04 INFO - Downloading blobuploader-1.2.4.tar.gz 14:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:08:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:08: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 14:08: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 14:08: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 14:08: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 14:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:08:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:08: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 14:08: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 14:08: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 14:08: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 14:08:04 INFO - Downloading docopt-0.6.1.tar.gz 14:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:08:05 INFO - Installing collected packages: blobuploader, requests, docopt 14:08:05 INFO - Running setup.py install for blobuploader 14:08:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:08:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:08:05 INFO - Running setup.py install for requests 14:08:05 INFO - Running setup.py install for docopt 14:08:05 INFO - Successfully installed blobuploader requests docopt 14:08:05 INFO - Cleaning up... 14:08:05 INFO - Return code: 0 14:08:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:05 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')]} 14:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:05 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')]} 14:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:05 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 0x23591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c5eb0>, '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 0x26c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c7240>, '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': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', '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 14:08:05 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 14:08:05 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 14:08:05 INFO - Using env: {'DISPLAY': ':0', 14:08:05 INFO - 'HOME': '/home/cltbld', 14:08:05 INFO - 'LANG': 'en_US.UTF-8', 14:08:05 INFO - 'LANGUAGE': 'en_US:en', 14:08:05 INFO - 'LOGNAME': 'cltbld', 14:08:05 INFO - 'MAIL': '/var/mail/cltbld', 14:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:05 INFO - 'MOZ_NO_REMOTE': '1', 14:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:05 INFO - 'NO_EM_RESTART': '1', 14:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:05 INFO - 'PWD': '/builds/slave/test', 14:08:05 INFO - 'SHELL': '/bin/bash', 14:08:05 INFO - 'SHLVL': '1', 14:08:05 INFO - 'TERM': 'linux', 14:08:05 INFO - 'TMOUT': '86400', 14:08:05 INFO - 'USER': 'cltbld', 14:08:05 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', 14:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:05 INFO - '_': '/tools/buildbot/bin/python'} 14:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:05 INFO - Running setup.py (path:/tmp/pip-uuRGkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:05 INFO - Running setup.py (path:/tmp/pip-JVVzmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:06 INFO - Running setup.py (path:/tmp/pip-F0Ser4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:06 INFO - Running setup.py (path:/tmp/pip-yjUSpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:06 INFO - Running setup.py (path:/tmp/pip-_njBWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:06 INFO - Running setup.py (path:/tmp/pip-x9mr7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:06 INFO - Running setup.py (path:/tmp/pip-0DFw6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:06 INFO - Running setup.py (path:/tmp/pip-6Zbicg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:06 INFO - Running setup.py (path:/tmp/pip-6iwYHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:06 INFO - Running setup.py (path:/tmp/pip-1djaDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:06 INFO - Running setup.py (path:/tmp/pip-eAqpSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:06 INFO - Running setup.py (path:/tmp/pip-QvVSeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:06 INFO - Running setup.py (path:/tmp/pip-nQmSbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:06 INFO - Running setup.py (path:/tmp/pip-nmDCjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:06 INFO - Running setup.py (path:/tmp/pip-Cw1K82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:06 INFO - Running setup.py (path:/tmp/pip-Ftnn8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:07 INFO - Running setup.py (path:/tmp/pip-isiyOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:08:07 INFO - Running setup.py install for manifestparser 14:08:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:08:07 INFO - Running setup.py install for mozcrash 14:08:07 INFO - Running setup.py install for mozdebug 14:08:07 INFO - Running setup.py install for mozdevice 14:08:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:08:07 INFO - Running setup.py install for mozfile 14:08:07 INFO - Running setup.py install for mozhttpd 14:08:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:08:07 INFO - Running setup.py install for mozinfo 14:08:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:08:07 INFO - Running setup.py install for mozInstall 14:08:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:08:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:08:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:08:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:08:07 INFO - Running setup.py install for mozleak 14:08:07 INFO - Running setup.py install for mozlog 14:08:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:08:08 INFO - Running setup.py install for moznetwork 14:08:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:08:08 INFO - Running setup.py install for mozprocess 14:08:08 INFO - Running setup.py install for mozprofile 14:08:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:08:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:08:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:08:08 INFO - Running setup.py install for mozrunner 14:08:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:08:08 INFO - Running setup.py install for mozscreenshot 14:08:08 INFO - Running setup.py install for moztest 14:08:08 INFO - Running setup.py install for mozversion 14:08:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:08:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:08:08 INFO - Cleaning up... 14:08:08 INFO - Return code: 0 14:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:08 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 0x23591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c5eb0>, '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 0x26c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c7240>, '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': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', '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 14:08:08 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 14:08:08 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 14:08:08 INFO - Using env: {'DISPLAY': ':0', 14:08:08 INFO - 'HOME': '/home/cltbld', 14:08:08 INFO - 'LANG': 'en_US.UTF-8', 14:08:08 INFO - 'LANGUAGE': 'en_US:en', 14:08:08 INFO - 'LOGNAME': 'cltbld', 14:08:08 INFO - 'MAIL': '/var/mail/cltbld', 14:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:08 INFO - 'MOZ_NO_REMOTE': '1', 14:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:08 INFO - 'NO_EM_RESTART': '1', 14:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:08 INFO - 'PWD': '/builds/slave/test', 14:08:08 INFO - 'SHELL': '/bin/bash', 14:08:08 INFO - 'SHLVL': '1', 14:08:08 INFO - 'TERM': 'linux', 14:08:08 INFO - 'TMOUT': '86400', 14:08:08 INFO - 'USER': 'cltbld', 14:08:08 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', 14:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:08 INFO - '_': '/tools/buildbot/bin/python'} 14:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:08:09 INFO - Running setup.py (path:/tmp/pip-bSEiLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:08:09 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)) 14:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:08:09 INFO - Running setup.py (path:/tmp/pip-jwsN6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:08:09 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)) 14:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:08:09 INFO - Running setup.py (path:/tmp/pip-dVHIHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:08:09 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)) 14:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:08:09 INFO - Running setup.py (path:/tmp/pip-yeW5pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:08:09 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)) 14:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:08:09 INFO - Running setup.py (path:/tmp/pip-Ly7zn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:08:09 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)) 14:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:08:09 INFO - Running setup.py (path:/tmp/pip-eS61JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:08:09 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)) 14:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:08:09 INFO - Running setup.py (path:/tmp/pip-N4YZCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:08:09 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)) 14:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:08:09 INFO - Running setup.py (path:/tmp/pip-hBz5Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:08:09 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)) 14:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:08:09 INFO - Running setup.py (path:/tmp/pip-K1Ul_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:08:09 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)) 14:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:08:09 INFO - Running setup.py (path:/tmp/pip-rP7vZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:08:09 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)) 14:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:08:09 INFO - Running setup.py (path:/tmp/pip-PTLoBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:08:09 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)) 14:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:08:09 INFO - Running setup.py (path:/tmp/pip-9zyOJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:08:09 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)) 14:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:08:10 INFO - Running setup.py (path:/tmp/pip-j5V_Eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:08:10 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)) 14:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:08:10 INFO - Running setup.py (path:/tmp/pip-MxIifI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:08:10 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)) 14:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:10 INFO - Running setup.py (path:/tmp/pip-4AHfj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:08:10 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)) 14:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:08:10 INFO - Running setup.py (path:/tmp/pip-wJV050-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:08:10 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)) 14:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:08:10 INFO - Running setup.py (path:/tmp/pip-VLVdHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:08:10 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)) 14:08:10 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)) 14:08:10 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)) 14:08:10 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)) 14:08:10 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)) 14:08:10 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)) 14:08:10 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)) 14:08:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:08:11 INFO - Downloading blessings-1.6.tar.gz 14:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:08:11 INFO - Installing collected packages: blessings 14:08:11 INFO - Running setup.py install for blessings 14:08:11 INFO - Successfully installed blessings 14:08:11 INFO - Cleaning up... 14:08:11 INFO - Return code: 0 14:08:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:08:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:11 INFO - Reading from file tmpfile_stdout 14:08:11 INFO - Current package versions: 14:08:11 INFO - argparse == 1.2.1 14:08:11 INFO - blessings == 1.6 14:08:11 INFO - blobuploader == 1.2.4 14:08:11 INFO - docopt == 0.6.1 14:08:11 INFO - functools32 == 3.2.3-2 14:08:11 INFO - jsonschema == 2.5.1 14:08:11 INFO - manifestparser == 1.1 14:08:11 INFO - mozInstall == 1.13 14:08:11 INFO - mozcrash == 1.0 14:08:11 INFO - mozdebug == 0.1 14:08:11 INFO - mozdevice == 0.51 14:08:11 INFO - mozfile == 1.2 14:08:11 INFO - mozhttpd == 0.7 14:08:11 INFO - mozinfo == 0.10 14:08:11 INFO - mozleak == 0.1 14:08:11 INFO - mozlog == 3.5 14:08:11 INFO - moznetwork == 0.27 14:08:11 INFO - mozprocess == 0.25 14:08:11 INFO - mozprofile == 0.28 14:08:11 INFO - mozrunner == 6.13 14:08:11 INFO - mozscreenshot == 0.1 14:08:11 INFO - mozsystemmonitor == 0.3 14:08:11 INFO - moztest == 0.8 14:08:11 INFO - mozversion == 1.4 14:08:11 INFO - psutil == 3.1.1 14:08:11 INFO - requests == 1.2.3 14:08:11 INFO - wsgiref == 0.1.2 14:08:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:11 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 0x23591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c5eb0>, '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 0x26c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c7240>, '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': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', '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 14:08:11 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 14:08:11 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 14:08:11 INFO - Using env: {'DISPLAY': ':0', 14:08:11 INFO - 'HOME': '/home/cltbld', 14:08:11 INFO - 'LANG': 'en_US.UTF-8', 14:08:11 INFO - 'LANGUAGE': 'en_US:en', 14:08:11 INFO - 'LOGNAME': 'cltbld', 14:08:11 INFO - 'MAIL': '/var/mail/cltbld', 14:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:11 INFO - 'MOZ_NO_REMOTE': '1', 14:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:11 INFO - 'NO_EM_RESTART': '1', 14:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:11 INFO - 'PWD': '/builds/slave/test', 14:08:11 INFO - 'SHELL': '/bin/bash', 14:08:11 INFO - 'SHLVL': '1', 14:08:11 INFO - 'TERM': 'linux', 14:08:11 INFO - 'TMOUT': '86400', 14:08:11 INFO - 'USER': 'cltbld', 14:08:11 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', 14:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:11 INFO - '_': '/tools/buildbot/bin/python'} 14:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:12 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)) 14:08:12 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)) 14:08:12 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)) 14:08:12 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)) 14:08:12 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)) 14:08:12 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)) 14:08:12 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)) 14:08:12 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)) 14:08:12 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)) 14:08:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:08:12 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 14:08:12 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 14:08:12 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 14:08:12 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 14:08:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:08:13 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)) 14:08:13 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)) 14:08:13 INFO - Installing collected packages: simplejson 14:08:13 INFO - Running setup.py install for simplejson 14:08:13 INFO - building 'simplejson._speedups' extension 14:08:13 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 14:08:14 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 14:08:14 INFO - Successfully installed simplejson 14:08:14 INFO - Cleaning up... 14:08:14 INFO - Return code: 0 14:08:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:08:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23591f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2525a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26c8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c5eb0>, '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 0x26c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c7240>, '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': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', '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 14:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:08:14 INFO - Using env: {'DISPLAY': ':0', 14:08:14 INFO - 'HOME': '/home/cltbld', 14:08:14 INFO - 'LANG': 'en_US.UTF-8', 14:08:14 INFO - 'LANGUAGE': 'en_US:en', 14:08:14 INFO - 'LOGNAME': 'cltbld', 14:08:14 INFO - 'MAIL': '/var/mail/cltbld', 14:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:14 INFO - 'MOZ_NO_REMOTE': '1', 14:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:14 INFO - 'NO_EM_RESTART': '1', 14:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:14 INFO - 'PWD': '/builds/slave/test', 14:08:14 INFO - 'SHELL': '/bin/bash', 14:08:14 INFO - 'SHLVL': '1', 14:08:14 INFO - 'TERM': 'linux', 14:08:14 INFO - 'TMOUT': '86400', 14:08:14 INFO - 'USER': 'cltbld', 14:08:14 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', 14:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:14 INFO - '_': '/tools/buildbot/bin/python'} 14:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:08:14 INFO - Cleaning up... 14:08:14 INFO - Return code: 0 14:08:14 INFO - Running post-action listener: _resource_record_post_action 14:08:14 INFO - Running post-action listener: _start_resource_monitoring 14:08:14 INFO - Starting resource monitoring. 14:08:14 INFO - [mozharness: 2017-08-01 21:08:14.611461Z] Finished create-virtualenv step (success) 14:08:14 INFO - [mozharness: 2017-08-01 21:08:14.611973Z] Running install step. 14:08:14 INFO - Running pre-action listener: _resource_record_pre_action 14:08:14 INFO - Running main action method: install 14:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:08:14 INFO - Reading from file tmpfile_stdout 14:08:14 INFO - Detecting whether we're running mozinstall >=1.0... 14:08:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:08:14 INFO - Reading from file tmpfile_stdout 14:08:14 INFO - Output received: 14:08:14 INFO - Usage: mozinstall [options] installer 14:08:14 INFO - Options: 14:08:14 INFO - -h, --help show this help message and exit 14:08:14 INFO - -d DEST, --destination=DEST 14:08:14 INFO - Directory to install application into. [default: 14:08:14 INFO - "/builds/slave/test"] 14:08:14 INFO - --app=APP Application being installed. [default: firefox] 14:08:14 INFO - mkdir: /builds/slave/test/build/application 14:08:14 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'] 14:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:08:32 INFO - Reading from file tmpfile_stdout 14:08:32 INFO - Output received: 14:08:32 INFO - /builds/slave/test/build/application/firefox/firefox 14:08:32 INFO - Running post-action listener: _resource_record_post_action 14:08:32 INFO - [mozharness: 2017-08-01 21:08:32.952128Z] Finished install step (success) 14:08:32 INFO - [mozharness: 2017-08-01 21:08:32.952380Z] Running setup-mitmproxy step. 14:08:32 INFO - Running pre-action listener: _resource_record_pre_action 14:08:32 INFO - Running main action method: setup_mitmproxy 14:08:32 INFO - Skipping: mitmproxy is not required 14:08:32 INFO - Running post-action listener: _resource_record_post_action 14:08:32 INFO - [mozharness: 2017-08-01 21:08:32.953540Z] Finished setup-mitmproxy step (success) 14:08:32 INFO - [mozharness: 2017-08-01 21:08:32.953773Z] Running run-tests step. 14:08:32 INFO - Running pre-action listener: _resource_record_pre_action 14:08:32 INFO - Running pre-action listener: _set_gcov_prefix 14:08:32 INFO - Running main action method: run_tests 14:08:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:08:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:08:32 INFO - Python 2.7.3 14:08:32 INFO - Return code: 0 14:08:32 INFO - grabbing minidump binary from tooltool 14:08:32 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')]} 14:08:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26c5eb0>, '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 0x26c6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26c7240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:08:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:08:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:08:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:08:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:08:33 INFO - Return code: 0 14:08:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:08:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:08:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:08:33 INFO - ENV: RUST_BACKTRACE is now 1 14:08:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:08:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:08:33 INFO - Using env: {'DISPLAY': ':0', 14:08:33 INFO - 'HOME': '/home/cltbld', 14:08:33 INFO - 'LANG': 'en_US.UTF-8', 14:08:33 INFO - 'LANGUAGE': 'en_US:en', 14:08:33 INFO - 'LOGNAME': 'cltbld', 14:08:33 INFO - 'MAIL': '/var/mail/cltbld', 14:08:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:08:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:08:33 INFO - 'MOZ_NO_REMOTE': '1', 14:08:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:08:33 INFO - 'NO_EM_RESTART': '1', 14:08:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:08:33 INFO - 'PWD': '/builds/slave/test', 14:08:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:08:33 INFO - 'RUST_BACKTRACE': '1', 14:08:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:08:33 INFO - 'SHELL': '/bin/bash', 14:08:33 INFO - 'SHLVL': '1', 14:08:33 INFO - 'STYLO_FORCE_ENABLED': '1', 14:08:33 INFO - 'TERM': 'linux', 14:08:33 INFO - 'TMOUT': '86400', 14:08:33 INFO - 'USER': 'cltbld', 14:08:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648', 14:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:08:33 INFO - '_': '/tools/buildbot/bin/python'} 14:08:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:08:33 INFO - mozversion application_buildid: 20170801201729 14:08:33 INFO - mozversion application_changeset: a3e675a3b10a0ea289c301bedc31866f3daf7875 14:08:33 INFO - mozversion application_display_name: Nightly 14:08:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:08:33 INFO - mozversion application_name: Firefox 14:08:33 INFO - mozversion application_remotingname: firefox 14:08:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:08:33 INFO - mozversion application_vendor: Mozilla 14:08:33 INFO - mozversion application_version: 56.0a1 14:08:33 INFO - mozversion platform_buildid: 20170801201729 14:08:33 INFO - mozversion platform_changeset: a3e675a3b10a0ea289c301bedc31866f3daf7875 14:08:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:08:33 INFO - mozversion platform_version: 56.0a1 14:08:33 INFO - using testdate: 1501621713 14:08:33 INFO - actual date: 1501621713 14:08:33 INFO - starting webserver on 'localhost:44473' 14:08:33 INFO - SUITE-START | Running 2 tests 14:08:33 INFO - TEST-START | dromaeo_css 14:08:33 INFO - Initialising browser for dromaeo_css test... 14:08:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44473/getInfo.html -profile /tmp/tmpCRspMd/profile 14:08:33 INFO - TEST-INFO | started process 11174 (/builds/slave/test/build/application/firefox/firefox http://localhost:44473/getInfo.html) 14:08:39 INFO - TEST-INFO | 11174: exit 0 14:08:39 INFO - Browser initialized. 14:08:39 INFO - Running cycle 1/1 for dromaeo_css test... 14:08:39 INFO - TEST-INFO | started process 11399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCRspMd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:40 INFO - PID 11399 | 14:08:40 INFO - PID 11399 | (/builds/slave/test/build/application/firefox/firefox:11453): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:08:40 INFO - PID 11399 | 14:08:50 INFO - PID 11399 | RSS: Main: 174465024 14:08:50 INFO - PID 11399 | 14:11:50 INFO - PID 11399 | Cycle 1(1): loaded http://localhost:44473/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44473/tests/dromaeo/cssquery-ext.html) 14:11:51 INFO - PID 11399 | RSS: Main: 176197632 14:11:51 INFO - PID 11399 | 14:14:53 INFO - PID 11399 | Cycle 1(1): loaded http://localhost:44473/tests/dromaeo/cssquery-ext.html (next: http://localhost:44473/tests/dromaeo/cssquery-jquery.html) 14:14:54 INFO - PID 11399 | RSS: Main: 173703168 14:14:54 INFO - PID 11399 | 14:17:56 INFO - PID 11399 | Cycle 1(1): loaded http://localhost:44473/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44473/tests/dromaeo/cssquery-mootools.html) 14:17:56 INFO - PID 11399 | RSS: Main: 175702016 14:17:56 INFO - PID 11399 | 14:20:58 INFO - PID 11399 | Cycle 1(1): loaded http://localhost:44473/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44473/tests/dromaeo/cssquery-prototype.html) 14:20:59 INFO - PID 11399 | RSS: Main: 174350336 14:20:59 INFO - PID 11399 | 14:24:02 INFO - PID 11399 | Cycle 1(1): loaded http://localhost:44473/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44473/tests/dromaeo/cssquery-yui.html) 14:24:03 INFO - PID 11399 | RSS: Main: 177778688 14:24:03 INFO - PID 11399 | 14:27:05 INFO - PID 11399 | Cycle 1(1): loaded http://localhost:44473/tests/dromaeo/cssquery-yui.html (next: http://localhost:44473/tests/dromaeo/cssquery-dojo.html) 14:27:05 INFO - PID 11399 | RSS: Main: 178466816 14:27:05 INFO - PID 11399 | 14:27:05 INFO - PID 11399 | __start_tp_report 14:27:05 INFO - PID 11399 | _x_x_mozilla_page_load 14:27:05 INFO - PID 11399 | _x_x_mozilla_page_load_details 14:27:05 INFO - PID 11399 | |i|pagename|runs| 14:27:05 INFO - PID 11399 | |0;dojo.html;3118.4854499007665;3152.369526094779;3181.7454603631713;3182.283986103127;3202.1994501374656;6161;6176.752929882805;6264.780732674358;6307.653079080649;6341.492680585554;6221.129041934133;6267.153934218879;6283.183186185789;6284.12022316876;6347.333529979355;5552.639078459907;5688.914666280009;5779.884402311972;5783.826485205451;5803.506701930341;5667.8583035424035;5694.6867922264255;5805.5065319447895;5806.361300256968;5825.970870145665;5696.231008813819;5719.48524632785;5801.564882633798;5813.6221145625395;5830.4169583041785;5671.574631902624;5705.400932902027;5785.88428231433;5791.276090488689;5806.419358064202;5507.7246137692955;5622.269105016363;5624.6343987641085;5634.915476267859;5715.057015592422;6073.726682299307;6118.326984031797;6128;6133.233345831771;6142.662153581551;6593.20881494219;6659.067730517731;6659.9001014984815;6662.800115996528;6681.33186681328;6708.9664551677415;6713.328667133296;6723.462123030145;6725.495587830932;6728.865422691568;6190.50475961922;6198;6204.193454850885;6206.441420272197;6210.751569937197;6954.7218111276;6980.336867997532;6985.965070174617;6999.825004374931;7012.649367531603;6585.407313341822;6647.468202543785;6676.031975363545;6690.899636505456;6693.029510720919;6669.733210671616;6717.5297729159465;6726.495512836557;6776.627285499345;6812.284710105368;6524.119243902107;6639;6639.43564796988;6670.899936500957;6728.529002969843;6496.123023391876;6685.364890335411;6711.932880671131;6774.187097548227;6855.897161542581;5351.277577527062;5353.705546194997;5404.648697834628;5443.755031023614;5445.618806683494;4538.931916021263;4552.772361381918;4640.489546149921;4647.18674232008;4673.135469938073;5741.741621627037;5748.827535173951;5871.970640146772;5875.823725288248;5879.823605291848;6841.2132604750095;6841.555298905555;6848.1097457330225;6848.554843935129;6860.862782744417;5795;5816.534677225812;5883.0293001654245;5884;5892.263467066617;5882.323839490238;5900.114982752536;5914.467697907209;5980.5215582754145;5996.580239383288;6293.748250069946;6439.871202576016;6512;6590.802275931538;6611.669416529155;6684.097646817811;6692.230393504809;6733.69698363565;6740.966295168493;6756;6440.066190402459;6485.092087107903;6489.091527186292;6508.837279068061;6521.087047813405;6585.176852893388;6617.205935287796;6639.800805975829;6643.169603799525;6650.933490665031;6694.59832410057;6700.43046341047;6713.966430167818;6792.72829086831;6825;6475.190601174853;6488.870222595616;6553.737850485927;6571.277159512545;6572.539922205399;6329.335419781041;6424.261209960728;6424.935750642434;6446.645434501147;6569.868602628017;6446.677666116581;6457.257415397289;6463.3213512580505;6532;6550.934490655032;6570.441512471493;6574.27682954865;6624.403803657694;6632.83417914556;6691.197056353269;6307.495400368051;6408.935910640834;6408.93591064102;6412.97392417211;6450.9354906450335 14:27:05 INFO - PID 11399 | |1;ext.html;800.2397722163946;843.5191940593865;866.7183165471222;889.7063968890265;895.6193617712471;39585.208295834105;40042.399364009565;40264.79867600661;40321.79839100801;40643.18713625726;38090.42864357037;38233.61766382335;38448.80775596118;38488.03779905504;38556.614433855655;6851.34912183343;6943.409810166142;6947.40947019504;6954.965225173867;6975.686094125776;6829.419499342562;6883.449324054063;6901.378875901168;6912.239653638121;6915;6875.6562171891455;7463.738769143081;7651.426143039266;7653.387728981668;7677.078750549914;7551.546907185559;7612.467127301091;7614.124375696811;7617;7630.618469076552;7459.627018649046;7551.509151905164;7568.508046976984;7573.204813494559;7582.393408527305;38043.61956380456;38628.61371386278;38765.224695506215;38801.80599097015;38872.41691374632;3406.982965085159;3433.4678124890684;3446.8621255150015;3450.27544215715;3453.706434953032;31669.683303166905;31697.52453713196;31710.524342134886;31732;31741.682583174334;4733.952660473386;4816.831410900637;4850.951490485085;4856.053069651384;4884.877878053042;182485;185461;191650;192297;194732.0263398688;48096.27855582169;48182.518174818506;48211.276830847564;48307.75846120817;48607.5139248603;49717.75141124271;49852.50147498551;49903.500964989886;49955.75022124866;50058.49941500611;16040.518784436486;16095;16149.35402583907;16210.189490525427;16552.668946621;13508.121972071784;13567.11813732124;13626.523071692642;13648.931755341358;13660.726785464236;14051.578452646438;14193.85806141946;14245.430182792572;14274.785878211835;14476.927615362067;5661.911007165939;5744.195812586241;5770.798022069207;5885.263352541089;5895.616784908967;982.2829334585649;987.950602469888;989.1987490133015;1017.7760892603616;1024.416082832793;21904.342869713935;22264.220752273915;22575.774242257696;22971;23320.950557224965;1062.3094988257694;1078.9685657176422;1090.1987039525943;1092.093562343253;1101.7576133250673;12182.431892626022;12440.564580239648;12469.438875250635;16295.34818607266;16415.83584164167;238590;240666;242622;244238;245936;56705;56892;56962.430375695716;56975;57197.42802571921;1452.9055611385227;1462.276173294226;1476.948306809278;1478.3790807860723;1484.5397926642775;25533.3616659585;28021;28086.157415277576;28091.859540702982;28286.292842679097;37970.62029379671;38174.61825381822;38247.235055299294;38311.42532861954;38411.2317753649;204417;205372;205372;205764;206769;32925;35006.299874002885;35091.298174036885;35101.122471938404;35342.82328588341;42844.57155428531;42849;43051.784741076095;48050.519494806;48678.513214867395;34296.48555271623;34351;34458.82770586131;34584.13539661529;35354.82322588371;33667.663323366454;34268.14329641779;34912.650873491955;34978.30043399169;35445.82277088701;38755.2248955025;38921.41617875791;39094;39431.211375772895;39456.80271598624;32504.83747581247;32933.83533082319;33024.66975330216;33046;33343.33313333671;23652.408689782893;24317.635235471836;24680.876595616908;24713.380882742335;24840.37899052538 14:27:05 INFO - PID 11399 | |2;jquery.html;556.6548739781337;561.6828537080545;565.8500497368199;578.4793685682885;591.446997057751;21701.45746356342;22120;22229.333120006406;22262.332130036084;22325.888370558165;26827.865860670718;27541;27599.31001724953;27634.447311053817;27752.028678996237;6892.310768923106;7079.044329015568;7083.468739844532;7091.3263239992375;7092.90060040692;6636.568623039487;6978.162620485549;6989.16130064393;7009.614471204081;7026.191987921377;6951.826204344907;6988.301169883021;6990.825229369256;6998.0552625395685;6998.370146686797;6910.965445172767;6940.514164008521;6941.930580694179;6970.059042029337;6973.51185417021;6829.590224586541;6831.351021652935;6846.7945961621235;6854.760083397107;6864.5881247125335;30398.54402183969;31042;31153.37693246145;31209;31244;1951.5706544560173;1969.3894892583346;1971.6352474792209;1975.6443840108775;1986.3941497843152;19777.208911643516;20458.283960061475;20503.2823851166;20528.897355513276;20555.79444205569;2338.1816364272368;2394.257780088178;2415.577273977047;2426.3327584914114;2466.432720474301;139712;145757.27121364325;146136;146319.99999999892;146496;20498.01155099025;21157.471063223235;21912.561748765253;22086.337409877728;22776.31671049871;22544.436389090075;23261.18585849487;44573.77713111414;44698.329525057154;44859.55140448619;9797.755056123653;9872.259580531489;9960.103590676874;10055.547500362502;10099.646512372032;9042.773930651787;9055.18503334703;9058;9173.862392064124;9200.35597508168;9488.620455181854;9653.855192171983;9696.563654635558;9764.609415623296;9780.755481112887;2665.986670066637;2719.972800271972;2786.1163695574983;2786.359137398369;2797.720227977227;942.2169987500192;957.2676902169845;969.9127078562963;976.5019839881569;998.6754304850953;19740.90129549343;20137.274604198272;20273.29043483471;20568.382948511568;20600.27899023557;1015.3958394755109;1026.3380119822673;1027.1166796554958;1047.8952104789612;1050.8056009638242;11188.992990630883;11225.887741122648;11326.830097548544;11361.431928403712;11577.363245021605;519760;522422;528805;534503;534583;117506.41246793882;122316.38841805734;123308;127933;130504;1253.6364454308332;1270.3076823131416;1303.1985329022582;1303.296220041167;1309.5285697149018;19847.801521984595;20581.691274630593;20827.8958605206;21517.677234841176;21830.781692182874;58525;60204.39795601988;60387.698061509414;60504.39495604987;62483.37516624957;68451.3154868445;68504.31495684979;68719.3128068713;68960.3103968954;69352;14880.40478380896;15075.472358467401;15100.320485578395;15148.621284467976;15248.695026099638;23735.643965340187;23778.881105594362;24072.39819004469;24237.151699690425;24285.757142429058;18412.81587184111;18554.814451855847;19478.707819383006;19658.50853728668;19673.901630491757;16396;16784.920733990763;17409.303627854744;17544.21051052731;18008.279668813102;19834.702479463107;19943.301984430476;19978.30075947335;20051.197952081755;20462.897685511478;14490.927545362205;14614.926925365306;14701.632459188178;14704.117752934859;14704.705905881608;17931.910340448216;18909.43271701851;18937.147828348032;19075.04624768784;19084.713729294348 14:27:05 INFO - PID 11399 | |3;mootools.html;1347.8921686265096;1388.8125103111083;1400.7478653842304;1405.1358414575036;1405.465922949279;13665.931670341646;14425.783613245796;14434.855651443482;14438.350274237659;14440.422383104664;13829.446822127104;14457.493987710432;14842.925785371059;14858.554243372717;14869.182194979272;2685.6642919635046;2732.4261904999976;2732.945341093187;2733.4533093381306;2733.7812974961957;2596.480703859226;2629.53983052965;2650.536156172672;2650.774684151849;2709.2549548874117;2669.5595226787555;2711.1053352393665;2727.9590806137926;2728.5088684036864;2734.1387462949106;2708.8510131942835;2732.7130651281627;2740.410811675499;2744.2041807875694;2744.2727677165567;2587.8964841406323;2592.4426248356694;2620.882060307291;2641.7622413982835;2648.5365061114226;14001.929990350085;14025.71948561023;14152.92923535386;14171.574852754435;14216.786748198785;7797.688092476351;8104.1085480597085;8142.796430089236;8145.837083258301;8155.306798922099;5193.714345710984;5298.443663415363;5314.043472175007;5345.385280692732;5423.647462914898;1824.635072985395;1839.2551016838202;1842.171023039624;1878.7369768232459;1882.6705326567933;23141.0743570257;23565.528689426115;23582.764172358227;23607.173748918707;23641.527169456516;6833.077534532775;7050.118735158106;7078.929210707827;7272.672729727175;7288.599127047957;15171.620709482131;16227.675446491241;18541.907290463463;18556.257749690132;18561.90719046423;7557.244275572509;7770.378369730521;7782.338501227346;7829.686812527435;7838.451308408356;7132.679029443688;7172.6055066970775;7198.208197098315;7209.855802883913;7263.2736726328;4977.153883839684;5046.798128074836;5093.898122037538;5134.255532947702;5134.897302053938;1404.6558593144746;1423.9074460160057;1437.8634029767156;1442.5095467541087;1451.4702133721328;839.8194388206565;853.2065179383234;857.4298091768903;876.5266755951842;899.0380293086465;6770.424513916372;6800.965995169992;6916.792496225121;6980.267071957473;7045.753398631024;714.3820595185127;724.3191400083904;736.1975446763054;737.0701461689847;742.3281929853491;4168.416421700964;4445.377647129404;4572.5198854119835;4771.308160316735;5098;18455.723164152547;18676.25294988185;18935;20101.6984745226;20166.495837604176;19653.803461965483;19664.115114819866;19873.801261987483;19999.300024499073;20049.799502005084;10287.27989040775;10430.37417754937;10631.30896491741;11079;11248.94375528117;7056.8588628226125;7356.264373562601;7603.201663825219;7626.54240745557;7782.260685234894;16580;16614.25235864413;16727.749083763996;16763.748543772097;17525.47423577295;16838.915805420893;17336.739948901028;17337.913310433367;17596.648067038845;17852.732209017136;11447.484863181344;11736.413179341169;11791.469383877575;11795.410229488663;11795.469203885674;12442.564510242099;13115.27865967381;13291.136076155019;13327.800082998956;13341.533046343331;10315.226358023028;10755.569777209137;10836.729081773019;11049.779004420026;11185.832212516656;10003.799924001625;10302.072813446826;10471.057604815604;10474.738131546772;10727.678169654922;9628.133467987915;9749.9025009749;9764.560594773395;9771.169450596779;9784.951075244579;6294.43350098475;6558.344165583403;6643.30245324234;6644.435223005905;6832.180138383425;7132.1441427029085;7256.2743725627015;7281.453890958093;7310.232425595449;7407 14:27:05 INFO - PID 11399 | |4;prototype.html;476.36881132499445;494.7773501924134;509.747674900924;512.0629248475291;519.2237604780851;6273.466755325803;6323.620582765032;6353.174087368641;6375.840603984902;6399.1681081459465;5999.350503359888;6116.143739876421;6192.040233763762;6194.566380353377;6281.246250449941;5019.347484826976;5046.97476512617;5062.962092770973;5069.873253168682;5097.439281679012;5022.246663000543;5030.170021946375;5030.974845125769;5052.4947505249365;5054.685781696749;4772.141014617368;4943.579795717368;4947.752612369367;4950.603951683875;4975.3532040834825;4946.356973593446;4953.133201689708;4966.87582810429;4990.451050384455;5006.974965125151;4402.207602631525;4420.58004489573;4431.7784110794655;4434.955650443519;4469.150861336336;6074.388013154342;6086.665233412161;6148.692565371758;6180.351063138396;6186.690665466709;5737.282839645044;5748.252727145445;5762.308522977228;5781.248437703071;5792.362840087587;6473.44975677068;6575;6644.136262285921;6644.269130395653;6662.267150613428;4803.471618122004;4838.395200599925;4861.246506791453;4865.781039853215;4880.1703710368965;6965.477589180831;7023.33278338557;7071.151461824614;7088.015355700412;7097.89353159703;4970.751462426936;4987.276844857475;5011.949880501148;5015.423226328946;5029.346184995927;5012.972340670154;5055.418626857959;5075.42661774851;5079.6698214615935;5086.491350864958;5650.632708873993;5730.455606717355;5733.455321744427;5749.1663708762;5784.3926387729525;6469.644169570624;6569.142423045991;6594.7032383542855;6599.769008084694;6765.255821859591;1666.9166541672869;1669.72449545826;1715.7254839225914;1753.9210735516933;1761.110639127258;1202.8977536909285;1206.390772659801;1207.2394391533278;1210.0138387214568;1223.9388030598434;5751.827445176651;5769.740361683735;5791.333996590446;5841.452015215971;5857.464695862454;6582.670866456658;6600.73597056122;6737.764178253738;6809;6823.795286141423;5739.655620662774;5794.783095549982;5813.56398270123;5821.53427725781;5834.562407819346;3591.299696559146;3666.6150054244454;3667.94498082529;3672.779633222015;3678.3930651442747;6563.737450502022;6589.736410543621;6618.768343108064;6650.935850263934;6665.100211471389;6968.860622787516;7027.648617569101;7039.416131370401;7079.398251148607;7099.757542430054;6473.838154046187;6540.901886471706;6542;6542.967285163544;6614.338566143443;6779.186497620317;6783.864322713617;6843.315668433117;6894.172699276119;6899.137607799025;6656.5340426169705;6713.1944166700305;6762.86474270502;6775;6794.233499290319;6555.672216389257;6592.43964263043;6671.499637527302;6694.732210711517;6710.362515561014;4914.778834952507;4945.950540494549;4962.255661650781;4979.950200497949;5014.4484106747495;6806.489513286622;6837.470136049495;6841.452683785185;6857.931420685929;6860.862782744417;6569.835754106186;6569.9014514783275;6576.2766095730385;6595.604263744191;6611.30581288977;6507.479401647762;6516.902246466212;6575.829976107777;6638.17022872141;6657.53397262187;6182.567220294536;6344.968275158594;6350.809475715736;6453;6548.410643042149;6151.907721384094;6489.513286503626;6553.836154095995;6578.618490117129;6618.974059020859;6253;6270.467010304175;6338.619682819046;6382.712777925098;6441.291457939529 14:27:05 INFO - PID 11399 | |5;yui.html;911.184489881556;919.1681528216964;928.0580211085745;930.1953809954383;949.1125797379449;17810.465686029438;17957;18960.146793394295;18976.525586860334;18984.145713442893;20771.273005444775;21483.67774483384;21671.45821354467;21703.34889953304;21813.67279490809;1003.2024540490328;1051.7318083888597;1055.2982266792574;1061.1298735037235;1061.6974162363729;1056.614335767447;1058.3279617442902;1069.6737495064003;1069.7165251208437;1070.1064611049783;1072.6621114348993;1119.8544189255385;1120.9607663731772;1121.8822023687517;1126.1553834624033;1089.7657003744232;1098.1489345757063;1103.911687065041;1108.501174471487;1108.9279196852178;791.3906292155066;793.7896457438783;796.8844517544924;797.1351084073787;797.1948332184535;17450.214740336716;17815.821841781544;19223.90388048051;19337;19365.709514357295;19402.12690428934;20379.490512737153;20759.5848083039;20764.68852967207;20803;14569.490067847575;14588.270586470633;14636.853631463762;14830.851691483163;14842.109473431628;3328.900132996014;3381.3744457275484;3392.6776956189124;3393.4570468725133;3396.3377141457427;123117.38441307825;127117;129485;130716;131777;15770.211489425712;15977.520674379788;16162.272697728631;16174.75737863933;16190.43333483346;30205;30215.244618884703;30252.84873575618;30323.090307290815;30385.544216836766;7613.733519326797;8502.574871256536;8809.251213646783;8823.55882205887;8863.069377715246;4117.279476091672;4223.767692776865;4226.535081141072;4273.572642735701;4424.7123936944;5201.661891977009;5354.491323324278;5355.277037599952;5364.409914909357;5364.946350536523;1057.4554104636118;1089.0525243038448;1098.505672447386;1104.6244276945877;1106.546316010448;672.6166085331314;674.9257581666013;689.3726708695064;710.6233696141054;714.9714011439588;11833.408329583659;12489.93755031219;13816;13966.301684915714;14005.439782408794;672.364615438406;699.9720011199597;700.9649517524103;704.9224585295614;713.2332742301942;5209.453007434241;5674.659520428788;5683.9874866320915;5757.309122905278;5796.188533605215;104876.47561762143;107412;108092.45953770338;110409;114451;89476.55261723649;94096.52951735197;97180;97524;99177;78522;80589.59705201436;80949;81335;82649;9845.950770246389;10450.529726162189;10645.361278323326;11624.302541847515;12686.238825670489;33946.49080263748;35969;36528.44300898912;37438.6256137446;39408.21183576255;66002.0546783813;66070;68424;68986.65506672434;74134;19483.025848707224;19499.70750438773;19707.211711531952;19708.50728731793;20011.699824502935;20986.47533811606;21243.256486022914;21463.678044829026;22010;22254.443638909157;18886.244550217838;19362;19566.21735130579;19567.315143969892;19803.10886010162;18080.276788928295;18498.722519162493;18667.719984199975;18944.242230310632;18957.526061848013;18498.81501184971;18668.533286667942;18688.25246990105;18948;19156.137973790934;12046.277223366626;12724;13667.931660341636;13748.587542373745;14321.64195895111;13895.166290022631;14770.48303309379;15065.397384104514;15080.54758357251;15554.688906222038 14:27:05 INFO - PID 11399 | __end_tp_report 14:27:05 INFO - PID 11399 | __start_cc_report 14:27:05 INFO - PID 11399 | _x_x_mozilla_cycle_collect,368 14:27:05 INFO - PID 11399 | __end_cc_report 14:27:05 INFO - PID 11399 | __startTimestamp1501622825738__endTimestamp 14:27:05 INFO - PID 11399 | 14:27:05 INFO - PID 11399 | ------- Summary: start ------- 14:27:05 INFO - PID 11399 | Number of tests: 6 14:27:05 INFO - PID 11399 | 14:27:05 INFO - PID 11399 | [#0] dojo.html Cycles:165 Average:6174.85 Median:6424.94 stddev:736.26 (11.5%) stddev-sans-first:698.38 14:27:05 INFO - PID 11399 | Values: 3118.5 3152.4 3181.7 3182.3 3202.2 6161.0 6176.8 6264.8 6307.7 6341.5 6221.1 6267.2 6283.2 6284.1 6347.3 5552.6 5688.9 5779.9 5783.8 5803.5 5667.9 5694.7 5805.5 5806.4 5826.0 5696.2 5719.5 5801.6 5813.6 5830.4 5671.6 5705.4 5785.9 5791.3 5806.4 5507.7 5622.3 5624.6 5634.9 5715.1 6073.7 6118.3 6128.0 6133.2 6142.7 6593.2 6659.1 6659.9 6662.8 6681.3 6709.0 6713.3 6723.5 6725.5 6728.9 6190.5 6198.0 6204.2 6206.4 6210.8 6954.7 6980.3 6986.0 6999.8 7012.6 6585.4 6647.5 6676.0 6690.9 6693.0 6669.7 6717.5 6726.5 6776.6 6812.3 6524.1 6639.0 6639.4 6670.9 6728.5 6496.1 6685.4 6711.9 6774.2 6855.9 5351.3 5353.7 5404.6 5443.8 5445.6 4538.9 4552.8 4640.5 4647.2 4673.1 5741.7 5748.8 5872.0 5875.8 5879.8 6841.2 6841.6 6848.1 6848.6 6860.9 5795.0 5816.5 5883.0 5884.0 5892.3 5882.3 5900.1 5914.5 5980.5 5996.6 6293.7 6439.9 6512.0 6590.8 6611.7 6684.1 6692.2 6733.7 6741.0 6756.0 6440.1 6485.1 6489.1 6508.8 6521.1 6585.2 6617.2 6639.8 6643.2 6650.9 6694.6 6700.4 6714.0 6792.7 6825.0 6475.2 6488.9 6553.7 6571.3 6572.5 6329.3 6424.3 6424.9 6446.6 6569.9 6446.7 6457.3 6463.3 6532.0 6550.9 6570.4 6574.3 6624.4 6632.8 6691.2 6307.5 6408.9 6408.9 6413.0 6450.9 14:27:05 INFO - PID 11399 | 14:27:05 INFO - PID 11399 | [#1] ext.html Cycles:180 Average:38561.95 Median:35400.32 stddev:55375.94 (156.4%) stddev-sans-first:55458.69 14:27:05 INFO - PID 11399 | Values: 800.2 843.5 866.7 889.7 895.6 39585.2 40042.4 40264.8 40321.8 40643.2 38090.4 38233.6 38448.8 38488.0 38556.6 6851.3 6943.4 6947.4 6955.0 6975.7 6829.4 6883.4 6901.4 6912.2 6915.0 6875.7 7463.7 7651.4 7653.4 7677.1 7551.5 7612.5 7614.1 7617.0 7630.6 7459.6 7551.5 7568.5 7573.2 7582.4 38043.6 38628.6 38765.2 38801.8 38872.4 3407.0 3433.5 3446.9 3450.3 3453.7 31669.7 31697.5 31710.5 31732.0 31741.7 4734.0 4816.8 4851.0 4856.1 4884.9 182485.0 185461.0 191650.0 192297.0 194732.0 48096.3 48182.5 48211.3 48307.8 48607.5 49717.8 49852.5 49903.5 49955.8 50058.5 16040.5 16095.0 16149.4 16210.2 16552.7 13508.1 13567.1 13626.5 13648.9 13660.7 14051.6 14193.9 14245.4 14274.8 14476.9 5661.9 5744.2 5770.8 5885.3 5895.6 982.3 988.0 989.2 1017.8 1024.4 21904.3 22264.2 22575.8 22971.0 23321.0 1062.3 1079.0 1090.2 1092.1 1101.8 12182.4 12440.6 12469.4 16295.3 16415.8 238590.0 240666.0 242622.0 244238.0 245936.0 56705.0 56892.0 56962.4 56975.0 57197.4 1452.9 1462.3 1476.9 1478.4 1484.5 25533.4 28021.0 28086.2 28091.9 28286.3 37970.6 38174.6 38247.2 38311.4 38411.2 204417.0 205372.0 205372.0 205764.0 206769.0 32925.0 35006.3 35091.3 35101.1 35342.8 42844.6 42849.0 43051.8 48050.5 48678.5 34296.5 34351.0 34458.8 34584.1 35354.8 33667.7 34268.1 34912.7 34978.3 35445.8 38755.2 38921.4 39094.0 39431.2 39456.8 32504.8 32933.8 33024.7 33046.0 33343.3 23652.4 24317.6 24680.9 24713.4 24840.4 14:27:05 INFO - PID 11399 | 14:27:05 INFO - PID 11399 | [#2] jquery.html Cycles:180 Average:37251.84 Median:23757.26 stddev:88783.46 (373.7%) stddev-sans-first:88989.78 14:27:05 INFO - PID 11399 | Values: 556.7 561.7 565.9 578.5 591.4 21701.5 22120.0 22229.3 22262.3 22325.9 26827.9 27541.0 27599.3 27634.4 27752.0 6892.3 7079.0 7083.5 7091.3 7092.9 6636.6 6978.2 6989.2 7009.6 7026.2 6951.8 6988.3 6990.8 6998.1 6998.4 6911.0 6940.5 6941.9 6970.1 6973.5 6829.6 6831.4 6846.8 6854.8 6864.6 30398.5 31042.0 31153.4 31209.0 31244.0 1951.6 1969.4 1971.6 1975.6 1986.4 19777.2 20458.3 20503.3 20528.9 20555.8 2338.2 2394.3 2415.6 2426.3 2466.4 139712.0 145757.3 146136.0 146320.0 146496.0 20498.0 21157.5 21912.6 22086.3 22776.3 22544.4 23261.2 44573.8 44698.3 44859.6 9797.8 9872.3 9960.1 10055.5 10099.6 9042.8 9055.2 9058.0 9173.9 9200.4 9488.6 9653.9 9696.6 9764.6 9780.8 2666.0 2720.0 2786.1 2786.4 2797.7 942.2 957.3 969.9 976.5 998.7 19740.9 20137.3 20273.3 20568.4 20600.3 1015.4 1026.3 1027.1 1047.9 1050.8 11189.0 11225.9 11326.8 11361.4 11577.4 519760.0 522422.0 528805.0 534503.0 534583.0 117506.4 122316.4 123308.0 127933.0 130504.0 1253.6 1270.3 1303.2 1303.3 1309.5 19847.8 20581.7 20827.9 21517.7 21830.8 58525.0 60204.4 60387.7 60504.4 62483.4 68451.3 68504.3 68719.3 68960.3 69352.0 14880.4 15075.5 15100.3 15148.6 15248.7 23735.6 23778.9 24072.4 24237.2 24285.8 18412.8 18554.8 19478.7 19658.5 19673.9 16396.0 16784.9 17409.3 17544.2 18008.3 19834.7 19943.3 19978.3 20051.2 20462.9 14490.9 14614.9 14701.6 14704.1 14704.7 17931.9 18909.4 18937.1 19075.0 19084.7 14:27:05 INFO - PID 11399 | 14:27:05 INFO - PID 11399 | [#3] mootools.html Cycles:180 Average:8801.37 Median:2645.15 stddev:6094.77 (230.4%) stddev-sans-first:6086.14 14:27:05 INFO - PID 11399 | Values: 1347.9 1388.8 1400.7 1405.1 1405.5 13665.9 14425.8 14434.9 14438.4 14440.4 13829.4 14457.5 14842.9 14858.6 14869.2 2685.7 2732.4 2732.9 2733.5 2733.8 2596.5 2629.5 2650.5 2650.8 2709.3 2669.6 2711.1 2728.0 2728.5 2734.1 2708.9 2732.7 2740.4 2744.2 2744.3 2587.9 2592.4 2620.9 2641.8 2648.5 14001.9 14025.7 14152.9 14171.6 14216.8 7797.7 8104.1 8142.8 8145.8 8155.3 5193.7 5298.4 5314.0 5345.4 5423.6 1824.6 1839.3 1842.2 1878.7 1882.7 23141.1 23565.5 23582.8 23607.2 23641.5 6833.1 7050.1 7078.9 7272.7 7288.6 15171.6 16227.7 18541.9 18556.3 18561.9 7557.2 7770.4 7782.3 7829.7 7838.5 7132.7 7172.6 7198.2 7209.9 7263.3 4977.2 5046.8 5093.9 5134.3 5134.9 1404.7 1423.9 1437.9 1442.5 1451.5 839.8 853.2 857.4 876.5 899.0 6770.4 6801.0 6916.8 6980.3 7045.8 714.4 724.3 736.2 737.1 742.3 4168.4 4445.4 4572.5 4771.3 5098.0 18455.7 18676.3 18935.0 20101.7 20166.5 19653.8 19664.1 19873.8 19999.3 20049.8 10287.3 10430.4 10631.3 11079.0 11248.9 7056.9 7356.3 7603.2 7626.5 7782.3 16580.0 16614.3 16727.7 16763.7 17525.5 16838.9 17336.7 17337.9 17596.6 17852.7 11447.5 11736.4 11791.5 11795.4 11795.5 12442.6 13115.3 13291.1 13327.8 13341.5 10315.2 10755.6 10836.7 11049.8 11185.8 10003.8 10302.1 10471.1 10474.7 10727.7 9628.1 9749.9 9764.6 9771.2 9785.0 6294.4 6558.3 6643.3 6644.4 6832.2 7132.1 7256.3 7281.5 7310.2 7407.0 14:27:05 INFO - PID 11399 | 14:27:05 INFO - PID 11399 | [#4] prototype.html Cycles:180 Average:5547.17 Median:6166.13 stddev:1572.67 (25.5%) stddev-sans-first:1530.34 14:27:05 INFO - PID 11399 | Values: 476.4 494.8 509.7 512.1 519.2 6273.5 6323.6 6353.2 6375.8 6399.2 5999.4 6116.1 6192.0 6194.6 6281.2 5019.3 5047.0 5063.0 5069.9 5097.4 5022.2 5030.2 5031.0 5052.5 5054.7 4772.1 4943.6 4947.8 4950.6 4975.4 4946.4 4953.1 4966.9 4990.5 5007.0 4402.2 4420.6 4431.8 4435.0 4469.2 6074.4 6086.7 6148.7 6180.4 6186.7 5737.3 5748.3 5762.3 5781.2 5792.4 6473.4 6575.0 6644.1 6644.3 6662.3 4803.5 4838.4 4861.2 4865.8 4880.2 6965.5 7023.3 7071.2 7088.0 7097.9 4970.8 4987.3 5011.9 5015.4 5029.3 5013.0 5055.4 5075.4 5079.7 5086.5 5650.6 5730.5 5733.5 5749.2 5784.4 6469.6 6569.1 6594.7 6599.8 6765.3 1666.9 1669.7 1715.7 1753.9 1761.1 1202.9 1206.4 1207.2 1210.0 1223.9 5751.8 5769.7 5791.3 5841.5 5857.5 6582.7 6600.7 6737.8 6809.0 6823.8 5739.7 5794.8 5813.6 5821.5 5834.6 3591.3 3666.6 3667.9 3672.8 3678.4 6563.7 6589.7 6618.8 6650.9 6665.1 6968.9 7027.6 7039.4 7079.4 7099.8 6473.8 6540.9 6542.0 6543.0 6614.3 6779.2 6783.9 6843.3 6894.2 6899.1 6656.5 6713.2 6762.9 6775.0 6794.2 6555.7 6592.4 6671.5 6694.7 6710.4 4914.8 4946.0 4962.3 4980.0 5014.4 6806.5 6837.5 6841.5 6857.9 6860.9 6569.8 6569.9 6576.3 6595.6 6611.3 6507.5 6516.9 6575.8 6638.2 6657.5 6182.6 6345.0 6350.8 6453.0 6548.4 6151.9 6489.5 6553.8 6578.6 6619.0 6253.0 6270.5 6338.6 6382.7 6441.3 14:27:05 INFO - PID 11399 | 14:27:05 INFO - PID 11399 | [#5] yui.html Cycles:180 Average:23486.12 Median:19637.26 stddev:31734.97 (161.6%) stddev-sans-first:31778.72 14:27:05 INFO - PID 11399 | Values: 911.2 919.2 928.1 930.2 949.1 17810.5 17957.0 18960.1 18976.5 18984.1 20771.3 21483.7 21671.5 21703.3 21813.7 1003.2 1051.7 1055.3 1061.1 1061.7 1056.6 1058.3 1069.7 1069.7 1070.1 1072.7 1119.9 1121.0 1121.9 1126.2 1089.8 1098.1 1103.9 1108.5 1108.9 791.4 793.8 796.9 797.1 797.2 17450.2 17815.8 19223.9 19337.0 19365.7 19402.1 20379.5 20759.6 20764.7 20803.0 14569.5 14588.3 14636.9 14830.9 14842.1 3328.9 3381.4 3392.7 3393.5 3396.3 123117.4 127117.0 129485.0 130716.0 131777.0 15770.2 15977.5 16162.3 16174.8 16190.4 30205.0 30215.2 30252.8 30323.1 30385.5 7613.7 8502.6 8809.3 8823.6 8863.1 4117.3 4223.8 4226.5 4273.6 4424.7 5201.7 5354.5 5355.3 5364.4 5364.9 1057.5 1089.1 1098.5 1104.6 1106.5 672.6 674.9 689.4 710.6 715.0 11833.4 12489.9 13816.0 13966.3 14005.4 672.4 700.0 701.0 704.9 713.2 5209.5 5674.7 5684.0 5757.3 5796.2 104876.5 107412.0 108092.5 110409.0 114451.0 89476.6 94096.5 97180.0 97524.0 99177.0 78522.0 80589.6 80949.0 81335.0 82649.0 9846.0 10450.5 10645.4 11624.3 12686.2 33946.5 35969.0 36528.4 37438.6 39408.2 66002.1 66070.0 68424.0 68986.7 74134.0 19483.0 19499.7 19707.2 19708.5 20011.7 20986.5 21243.3 21463.7 22010.0 22254.4 18886.2 19362.0 19566.2 19567.3 19803.1 18080.3 18498.7 18667.7 18944.2 18957.5 18498.8 18668.5 18688.3 18948.0 19156.1 12046.3 12724.0 13667.9 13748.6 14321.6 13895.2 14770.5 15065.4 15080.5 15554.7 14:27:05 INFO - PID 11399 | -------- Summary: end -------- 14:27:05 INFO - PID 11399 | 14:27:06 INFO - TEST-INFO | 11399: exit 0 14:27:06 INFO - TEST-OK | dromaeo_css | took 1113096ms 14:27:06 INFO - TEST-START | kraken 14:27:06 INFO - Initialising browser for kraken test... 14:27:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44473/getInfo.html -profile /tmp/tmpE41zXt/profile 14:27:06 INFO - TEST-INFO | started process 11779 (/builds/slave/test/build/application/firefox/firefox http://localhost:44473/getInfo.html) 14:27:12 INFO - TEST-INFO | 11779: exit 0 14:27:12 INFO - Browser initialized. 14:27:12 INFO - Running cycle 1/1 for kraken test... 14:27:12 INFO - TEST-INFO | started process 12002 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE41zXt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:27:13 INFO - PID 12002 | 14:27:13 INFO - PID 12002 | (/builds/slave/test/build/application/firefox/firefox:12057): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:27:13 INFO - PID 12002 | 14:27:23 INFO - PID 12002 | RSS: Main: 174297088 14:27:23 INFO - PID 12002 | 14:27:26 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44473/tests/kraken/driver.html?testName=audio-beat-detection) 14:27:27 INFO - PID 12002 | RSS: Main: 179167232 14:27:27 INFO - PID 12002 | 14:27:30 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44473/tests/kraken/driver.html?testName=audio-dft) 14:27:30 INFO - PID 12002 | RSS: Main: 179806208 14:27:30 INFO - PID 12002 | 14:27:33 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44473/tests/kraken/driver.html?testName=audio-fft) 14:27:34 INFO - PID 12002 | RSS: Main: 174510080 14:27:34 INFO - PID 12002 | 14:27:36 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44473/tests/kraken/driver.html?testName=audio-oscillator) 14:27:37 INFO - PID 12002 | RSS: Main: 175419392 14:27:37 INFO - PID 12002 | 14:27:39 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44473/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:27:40 INFO - PID 12002 | RSS: Main: 175681536 14:27:40 INFO - PID 12002 | 14:27:43 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44473/tests/kraken/driver.html?testName=imaging-darkroom) 14:27:43 INFO - PID 12002 | RSS: Main: 177700864 14:27:43 INFO - PID 12002 | 14:27:47 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44473/tests/kraken/driver.html?testName=imaging-desaturate) 14:27:48 INFO - PID 12002 | RSS: Main: 176898048 14:27:48 INFO - PID 12002 | 14:27:50 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44473/tests/kraken/driver.html?testName=json-parse-financial) 14:27:51 INFO - PID 12002 | RSS: Main: 177991680 14:27:51 INFO - PID 12002 | 14:27:53 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44473/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:27:53 INFO - PID 12002 | RSS: Main: 177876992 14:27:53 INFO - PID 12002 | 14:27:55 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44473/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:27:56 INFO - PID 12002 | RSS: Main: 174977024 14:27:56 INFO - PID 12002 | 14:27:58 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44473/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:27:59 INFO - PID 12002 | RSS: Main: 175194112 14:27:59 INFO - PID 12002 | 14:28:02 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:28:02 INFO - PID 12002 | RSS: Main: 175153152 14:28:02 INFO - PID 12002 | 14:28:05 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:28:06 INFO - PID 12002 | RSS: Main: 175464448 14:28:06 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | Cycle 1(1): loaded http://localhost:44473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44473/tests/kraken/driver.html?testName=ai-astar) 14:28:08 INFO - PID 12002 | RSS: Main: 176910336 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | __start_tp_report 14:28:08 INFO - PID 12002 | _x_x_mozilla_page_load 14:28:08 INFO - PID 12002 | _x_x_mozilla_page_load_details 14:28:08 INFO - PID 12002 | |i|pagename|runs| 14:28:08 INFO - PID 12002 | |0;ai-astar;99;112;100;109;110;114;108;105;111;111 14:28:08 INFO - PID 12002 | |1;audio-beat-detection;147;123;144;178;118;145;145;118;178;118 14:28:08 INFO - PID 12002 | |2;audio-dft;162;162;164;162;162;161;163;164;161;163 14:28:08 INFO - PID 12002 | |3;audio-fft;73;76;76;180;75;75;76;86;96;75 14:28:08 INFO - PID 12002 | |4;audio-oscillator;78;77;142;81;79;83;132;80;78;137 14:28:08 INFO - PID 12002 | |5;imaging-gaussian-blur;114;114;117;113;117;115;114;115;114;114 14:28:08 INFO - PID 12002 | |6;imaging-darkroom;151;152;151;151;150;152;153;155;159;152 14:28:08 INFO - PID 12002 | |7;imaging-desaturate;94;94;94;97;94;95;94;100;93;95 14:28:08 INFO - PID 12002 | |8;json-parse-financial;54;54;54;62;54;53;54;54;57;54 14:28:08 INFO - PID 12002 | |9;json-stringify-tinderbox;53;55;54;54;58;61;61;60;66;54 14:28:08 INFO - PID 12002 | |10;stanford-crypto-aes;78;90;77;94;80;77;76;97;78;92 14:28:08 INFO - PID 12002 | |11;stanford-crypto-ccm;127;142;134;132;141;130;123;124;127;162 14:28:08 INFO - PID 12002 | |12;stanford-crypto-pbkdf2;174;178;183;177;180;173;174;173;179;174 14:28:08 INFO - PID 12002 | |13;stanford-crypto-sha256-iterative;67;68;73;69;67;65;69;64;66;72 14:28:08 INFO - PID 12002 | __end_tp_report 14:28:08 INFO - PID 12002 | __start_cc_report 14:28:08 INFO - PID 12002 | _x_x_mozilla_cycle_collect,970 14:28:08 INFO - PID 12002 | __end_cc_report 14:28:08 INFO - PID 12002 | __startTimestamp1501622888667__endTimestamp 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | ------- Summary: start ------- 14:28:08 INFO - PID 12002 | Number of tests: 14 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#0] ai-astar Cycles:10 Average:107.90 Median:111.00 stddev:5.04 (4.5%) stddev-sans-first:4.20 14:28:08 INFO - PID 12002 | Values: 99.0 112.0 100.0 109.0 110.0 114.0 108.0 105.0 111.0 111.0 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:145.00 stddev:22.91 (15.8%) stddev-sans-first:24.21 14:28:08 INFO - PID 12002 | Values: 147.0 123.0 144.0 178.0 118.0 145.0 145.0 118.0 178.0 118.0 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 14:28:08 INFO - PID 12002 | Values: 162.0 162.0 164.0 162.0 162.0 161.0 163.0 164.0 161.0 163.0 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#3] audio-fft Cycles:10 Average:88.80 Median:76.00 stddev:32.81 (43.2%) stddev-sans-first:34.30 14:28:08 INFO - PID 12002 | Values: 73.0 76.0 76.0 180.0 75.0 75.0 76.0 86.0 96.0 75.0 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:78.50 stddev:27.96 (35.6%) stddev-sans-first:28.83 14:28:08 INFO - PID 12002 | Values: 78.0 77.0 142.0 81.0 79.0 83.0 132.0 80.0 78.0 137.0 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.34 (1.2%) stddev-sans-first:1.39 14:28:08 INFO - PID 12002 | Values: 114.0 114.0 117.0 113.0 117.0 115.0 114.0 115.0 114.0 114.0 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#6] imaging-darkroom Cycles:10 Average:152.60 Median:152.00 stddev:2.63 (1.7%) stddev-sans-first:2.73 14:28:08 INFO - PID 12002 | Values: 151.0 152.0 151.0 151.0 150.0 152.0 153.0 155.0 159.0 152.0 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.00 stddev:2.05 (2.2%) stddev-sans-first:2.15 14:28:08 INFO - PID 12002 | Values: 94.0 94.0 94.0 97.0 94.0 95.0 94.0 100.0 93.0 95.0 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:54.00 stddev:2.67 (4.9%) stddev-sans-first:2.80 14:28:08 INFO - PID 12002 | Values: 54.0 54.0 54.0 62.0 54.0 53.0 54.0 54.0 57.0 54.0 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:59.00 stddev:4.30 (7.3%) stddev-sans-first:4.23 14:28:08 INFO - PID 12002 | Values: 53.0 55.0 54.0 54.0 58.0 61.0 61.0 60.0 66.0 54.0 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:85.00 stddev:8.29 (9.8%) stddev-sans-first:8.52 14:28:08 INFO - PID 12002 | Values: 78.0 90.0 77.0 94.0 80.0 77.0 76.0 97.0 78.0 92.0 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:133.00 stddev:11.72 (8.8%) stddev-sans-first:12.13 14:28:08 INFO - PID 12002 | Values: 127.0 142.0 134.0 132.0 141.0 130.0 123.0 124.0 127.0 162.0 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:177.50 stddev:3.44 (1.9%) stddev-sans-first:3.53 14:28:08 INFO - PID 12002 | Values: 174.0 178.0 183.0 177.0 180.0 173.0 174.0 173.0 179.0 174.0 14:28:08 INFO - PID 12002 | 14:28:08 INFO - PID 12002 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:2.87 (4.2%) stddev-sans-first:3.02 14:28:08 INFO - PID 12002 | Values: 67.0 68.0 73.0 69.0 67.0 65.0 69.0 64.0 66.0 72.0 14:28:08 INFO - PID 12002 | -------- Summary: end -------- 14:28:08 INFO - PID 12002 | 14:28:09 INFO - PID 12002 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:28:09 INFO - TEST-INFO | 12002: exit 0 14:28:09 INFO - TEST-OK | kraken | took 63103ms 14:28:09 INFO - SUITE-END | took 1176s 14:28:09 INFO - Completed test suite (00:19:36) 14:28:09 INFO - javascript benchmark 14:28:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8580.342186409534, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.4854499007665, 3152.369526094779, 3181.7454603631713, 3182.283986103127, 3202.1994501374656, 6161.0, 6176.752929882805, 6264.780732674358, 6307.653079080649, 6341.492680585554, 6221.129041934133, 6267.153934218879, 6283.183186185789, 6284.12022316876, 6347.333529979355, 5552.639078459907, 5688.914666280009, 5779.884402311972, 5783.826485205451, 5803.506701930341, 5667.8583035424035, 5694.6867922264255, 5805.5065319447895, 5806.361300256968, 5825.970870145665, 5696.231008813819, 5719.48524632785, 5801.564882633798, 5813.6221145625395, 5830.4169583041785, 5671.574631902624, 5705.400932902027, 5785.88428231433, 5791.276090488689, 5806.419358064202, 5507.7246137692955, 5622.269105016363, 5624.6343987641085, 5634.915476267859, 5715.057015592422, 6073.726682299307, 6118.326984031797, 6128.0, 6133.233345831771, 6142.662153581551, 6593.20881494219, 6659.067730517731, 6659.9001014984815, 6662.800115996528, 6681.33186681328, 6708.9664551677415, 6713.328667133296, 6723.462123030145, 6725.495587830932, 6728.865422691568, 6190.50475961922, 6198.0, 6204.193454850885, 6206.441420272197, 6210.751569937197, 6954.7218111276, 6980.336867997532, 6985.965070174617, 6999.825004374931, 7012.649367531603, 6585.407313341822, 6647.468202543785, 6676.031975363545, 6690.899636505456, 6693.029510720919, 6669.733210671616, 6717.5297729159465, 6726.495512836557, 6776.627285499345, 6812.284710105368, 6524.119243902107, 6639.0, 6639.43564796988, 6670.899936500957, 6728.529002969843, 6496.123023391876, 6685.364890335411, 6711.932880671131, 6774.187097548227, 6855.897161542581, 5351.277577527062, 5353.705546194997, 5404.648697834628, 5443.755031023614, 5445.618806683494, 4538.931916021263, 4552.772361381918, 4640.489546149921, 4647.18674232008, 4673.135469938073, 5741.741621627037, 5748.827535173951, 5871.970640146772, 5875.823725288248, 5879.823605291848, 6841.2132604750095, 6841.555298905555, 6848.1097457330225, 6848.554843935129, 6860.862782744417, 5795.0, 5816.534677225812, 5883.0293001654245, 5884.0, 5892.263467066617, 5882.323839490238, 5900.114982752536, 5914.467697907209, 5980.5215582754145, 5996.580239383288, 6293.748250069946, 6439.871202576016, 6512.0, 6590.802275931538, 6611.669416529155, 6684.097646817811, 6692.230393504809, 6733.69698363565, 6740.966295168493, 6756.0, 6440.066190402459, 6485.092087107903, 6489.091527186292, 6508.837279068061, 6521.087047813405, 6585.176852893388, 6617.205935287796, 6639.800805975829, 6643.169603799525, 6650.933490665031, 6694.59832410057, 6700.43046341047, 6713.966430167818, 6792.72829086831, 6825.0, 6475.190601174853, 6488.870222595616, 6553.737850485927, 6571.277159512545, 6572.539922205399, 6329.335419781041, 6424.261209960728, 6424.935750642434, 6446.645434501147, 6569.868602628017, 6446.677666116581, 6457.257415397289, 6463.3213512580505, 6532.0, 6550.934490655032, 6570.441512471493, 6574.27682954865, 6624.403803657694, 6632.83417914556, 6691.197056353269, 6307.495400368051, 6408.935910640834, 6408.93591064102, 6412.97392417211, 6450.9354906450335], "value": 6119.179026141976, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.2397722163946, 843.5191940593865, 866.7183165471222, 889.7063968890265, 895.6193617712471, 39585.208295834105, 40042.399364009565, 40264.79867600661, 40321.79839100801, 40643.18713625726, 38090.42864357037, 38233.61766382335, 38448.80775596118, 38488.03779905504, 38556.614433855655, 6851.34912183343, 6943.409810166142, 6947.40947019504, 6954.965225173867, 6975.686094125776, 6829.419499342562, 6883.449324054063, 6901.378875901168, 6912.239653638121, 6915.0, 6875.6562171891455, 7463.738769143081, 7651.426143039266, 7653.387728981668, 7677.078750549914, 7551.546907185559, 7612.467127301091, 7614.124375696811, 7617.0, 7630.618469076552, 7459.627018649046, 7551.509151905164, 7568.508046976984, 7573.204813494559, 7582.393408527305, 38043.61956380456, 38628.61371386278, 38765.224695506215, 38801.80599097015, 38872.41691374632, 3406.982965085159, 3433.4678124890684, 3446.8621255150015, 3450.27544215715, 3453.706434953032, 31669.683303166905, 31697.52453713196, 31710.524342134886, 31732.0, 31741.682583174334, 4733.952660473386, 4816.831410900637, 4850.951490485085, 4856.053069651384, 4884.877878053042, 182485.0, 185461.0, 191650.0, 192297.0, 194732.0263398688, 48096.27855582169, 48182.518174818506, 48211.276830847564, 48307.75846120817, 48607.5139248603, 49717.75141124271, 49852.50147498551, 49903.500964989886, 49955.75022124866, 50058.49941500611, 16040.518784436486, 16095.0, 16149.35402583907, 16210.189490525427, 16552.668946621, 13508.121972071784, 13567.11813732124, 13626.523071692642, 13648.931755341358, 13660.726785464236, 14051.578452646438, 14193.85806141946, 14245.430182792572, 14274.785878211835, 14476.927615362067, 5661.911007165939, 5744.195812586241, 5770.798022069207, 5885.263352541089, 5895.616784908967, 982.2829334585649, 987.950602469888, 989.1987490133015, 1017.7760892603616, 1024.416082832793, 21904.342869713935, 22264.220752273915, 22575.774242257696, 22971.0, 23320.950557224965, 1062.3094988257694, 1078.9685657176422, 1090.1987039525943, 1092.093562343253, 1101.7576133250673, 12182.431892626022, 12440.564580239648, 12469.438875250635, 16295.34818607266, 16415.83584164167, 238590.0, 240666.0, 242622.0, 244238.0, 245936.0, 56705.0, 56892.0, 56962.430375695716, 56975.0, 57197.42802571921, 1452.9055611385227, 1462.276173294226, 1476.948306809278, 1478.3790807860723, 1484.5397926642775, 25533.3616659585, 28021.0, 28086.157415277576, 28091.859540702982, 28286.292842679097, 37970.62029379671, 38174.61825381822, 38247.235055299294, 38311.42532861954, 38411.2317753649, 204417.0, 205372.0, 205372.0, 205764.0, 206769.0, 32925.0, 35006.299874002885, 35091.298174036885, 35101.122471938404, 35342.82328588341, 42844.57155428531, 42849.0, 43051.784741076095, 48050.519494806, 48678.513214867395, 34296.48555271623, 34351.0, 34458.82770586131, 34584.13539661529, 35354.82322588371, 33667.663323366454, 34268.14329641779, 34912.650873491955, 34978.30043399169, 35445.82277088701, 38755.2248955025, 38921.41617875791, 39094.0, 39431.211375772895, 39456.80271598624, 32504.83747581247, 32933.83533082319, 33024.66975330216, 33046.0, 33343.33313333671, 23652.408689782893, 24317.635235471836, 24680.876595616908, 24713.380882742335, 24840.37899052538], "value": 17347.405265324578, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.6548739781337, 561.6828537080545, 565.8500497368199, 578.4793685682885, 591.446997057751, 21701.45746356342, 22120.0, 22229.333120006406, 22262.332130036084, 22325.888370558165, 26827.865860670718, 27541.0, 27599.31001724953, 27634.447311053817, 27752.028678996237, 6892.310768923106, 7079.044329015568, 7083.468739844532, 7091.3263239992375, 7092.90060040692, 6636.568623039487, 6978.162620485549, 6989.16130064393, 7009.614471204081, 7026.191987921377, 6951.826204344907, 6988.301169883021, 6990.825229369256, 6998.0552625395685, 6998.370146686797, 6910.965445172767, 6940.514164008521, 6941.930580694179, 6970.059042029337, 6973.51185417021, 6829.590224586541, 6831.351021652935, 6846.7945961621235, 6854.760083397107, 6864.5881247125335, 30398.54402183969, 31042.0, 31153.37693246145, 31209.0, 31244.0, 1951.5706544560173, 1969.3894892583346, 1971.6352474792209, 1975.6443840108775, 1986.3941497843152, 19777.208911643516, 20458.283960061475, 20503.2823851166, 20528.897355513276, 20555.79444205569, 2338.1816364272368, 2394.257780088178, 2415.577273977047, 2426.3327584914114, 2466.432720474301, 139712.0, 145757.27121364325, 146136.0, 146319.99999999892, 146496.0, 20498.01155099025, 21157.471063223235, 21912.561748765253, 22086.337409877728, 22776.31671049871, 22544.436389090075, 23261.18585849487, 44573.77713111414, 44698.329525057154, 44859.55140448619, 9797.755056123653, 9872.259580531489, 9960.103590676874, 10055.547500362502, 10099.646512372032, 9042.773930651787, 9055.18503334703, 9058.0, 9173.862392064124, 9200.35597508168, 9488.620455181854, 9653.855192171983, 9696.563654635558, 9764.609415623296, 9780.755481112887, 2665.986670066637, 2719.972800271972, 2786.1163695574983, 2786.359137398369, 2797.720227977227, 942.2169987500192, 957.2676902169845, 969.9127078562963, 976.5019839881569, 998.6754304850953, 19740.90129549343, 20137.274604198272, 20273.29043483471, 20568.382948511568, 20600.27899023557, 1015.3958394755109, 1026.3380119822673, 1027.1166796554958, 1047.8952104789612, 1050.8056009638242, 11188.992990630883, 11225.887741122648, 11326.830097548544, 11361.431928403712, 11577.363245021605, 519760.0, 522422.0, 528805.0, 534503.0, 534583.0, 117506.41246793882, 122316.38841805734, 123308.0, 127933.0, 130504.0, 1253.6364454308332, 1270.3076823131416, 1303.1985329022582, 1303.296220041167, 1309.5285697149018, 19847.801521984595, 20581.691274630593, 20827.8958605206, 21517.677234841176, 21830.781692182874, 58525.0, 60204.39795601988, 60387.698061509414, 60504.39495604987, 62483.37516624957, 68451.3154868445, 68504.31495684979, 68719.3128068713, 68960.3103968954, 69352.0, 14880.40478380896, 15075.472358467401, 15100.320485578395, 15148.621284467976, 15248.695026099638, 23735.643965340187, 23778.881105594362, 24072.39819004469, 24237.151699690425, 24285.757142429058, 18412.81587184111, 18554.814451855847, 19478.707819383006, 19658.50853728668, 19673.901630491757, 16396.0, 16784.920733990763, 17409.303627854744, 17544.21051052731, 18008.279668813102, 19834.702479463107, 19943.301984430476, 19978.30075947335, 20051.197952081755, 20462.897685511478, 14490.927545362205, 14614.926925365306, 14701.632459188178, 14704.117752934859, 14704.705905881608, 17931.910340448216, 18909.43271701851, 18937.147828348032, 19075.04624768784, 19084.713729294348], "value": 12680.653203616926, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.8921686265096, 1388.8125103111083, 1400.7478653842304, 1405.1358414575036, 1405.465922949279, 13665.931670341646, 14425.783613245796, 14434.855651443482, 14438.350274237659, 14440.422383104664, 13829.446822127104, 14457.493987710432, 14842.925785371059, 14858.554243372717, 14869.182194979272, 2685.6642919635046, 2732.4261904999976, 2732.945341093187, 2733.4533093381306, 2733.7812974961957, 2596.480703859226, 2629.53983052965, 2650.536156172672, 2650.774684151849, 2709.2549548874117, 2669.5595226787555, 2711.1053352393665, 2727.9590806137926, 2728.5088684036864, 2734.1387462949106, 2708.8510131942835, 2732.7130651281627, 2740.410811675499, 2744.2041807875694, 2744.2727677165567, 2587.8964841406323, 2592.4426248356694, 2620.882060307291, 2641.7622413982835, 2648.5365061114226, 14001.929990350085, 14025.71948561023, 14152.92923535386, 14171.574852754435, 14216.786748198785, 7797.688092476351, 8104.1085480597085, 8142.796430089236, 8145.837083258301, 8155.306798922099, 5193.714345710984, 5298.443663415363, 5314.043472175007, 5345.385280692732, 5423.647462914898, 1824.635072985395, 1839.2551016838202, 1842.171023039624, 1878.7369768232459, 1882.6705326567933, 23141.0743570257, 23565.528689426115, 23582.764172358227, 23607.173748918707, 23641.527169456516, 6833.077534532775, 7050.118735158106, 7078.929210707827, 7272.672729727175, 7288.599127047957, 15171.620709482131, 16227.675446491241, 18541.907290463463, 18556.257749690132, 18561.90719046423, 7557.244275572509, 7770.378369730521, 7782.338501227346, 7829.686812527435, 7838.451308408356, 7132.679029443688, 7172.6055066970775, 7198.208197098315, 7209.855802883913, 7263.2736726328, 4977.153883839684, 5046.798128074836, 5093.898122037538, 5134.255532947702, 5134.897302053938, 1404.6558593144746, 1423.9074460160057, 1437.8634029767156, 1442.5095467541087, 1451.4702133721328, 839.8194388206565, 853.2065179383234, 857.4298091768903, 876.5266755951842, 899.0380293086465, 6770.424513916372, 6800.965995169992, 6916.792496225121, 6980.267071957473, 7045.753398631024, 714.3820595185127, 724.3191400083904, 736.1975446763054, 737.0701461689847, 742.3281929853491, 4168.416421700964, 4445.377647129404, 4572.5198854119835, 4771.308160316735, 5098.0, 18455.723164152547, 18676.25294988185, 18935.0, 20101.6984745226, 20166.495837604176, 19653.803461965483, 19664.115114819866, 19873.801261987483, 19999.300024499073, 20049.799502005084, 10287.27989040775, 10430.37417754937, 10631.30896491741, 11079.0, 11248.94375528117, 7056.8588628226125, 7356.264373562601, 7603.201663825219, 7626.54240745557, 7782.260685234894, 16580.0, 16614.25235864413, 16727.749083763996, 16763.748543772097, 17525.47423577295, 16838.915805420893, 17336.739948901028, 17337.913310433367, 17596.648067038845, 17852.732209017136, 11447.484863181344, 11736.413179341169, 11791.469383877575, 11795.410229488663, 11795.469203885674, 12442.564510242099, 13115.27865967381, 13291.136076155019, 13327.800082998956, 13341.533046343331, 10315.226358023028, 10755.569777209137, 10836.729081773019, 11049.779004420026, 11185.832212516656, 10003.799924001625, 10302.072813446826, 10471.057604815604, 10474.738131546772, 10727.678169654922, 9628.133467987915, 9749.9025009749, 9764.560594773395, 9771.169450596779, 9784.951075244579, 6294.43350098475, 6558.344165583403, 6643.30245324234, 6644.435223005905, 6832.180138383425, 7132.1441427029085, 7256.2743725627015, 7281.453890958093, 7310.232425595449, 7407.0], "value": 6348.537161488764, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.36881132499445, 494.7773501924134, 509.747674900924, 512.0629248475291, 519.2237604780851, 6273.466755325803, 6323.620582765032, 6353.174087368641, 6375.840603984902, 6399.1681081459465, 5999.350503359888, 6116.143739876421, 6192.040233763762, 6194.566380353377, 6281.246250449941, 5019.347484826976, 5046.97476512617, 5062.962092770973, 5069.873253168682, 5097.439281679012, 5022.246663000543, 5030.170021946375, 5030.974845125769, 5052.4947505249365, 5054.685781696749, 4772.141014617368, 4943.579795717368, 4947.752612369367, 4950.603951683875, 4975.3532040834825, 4946.356973593446, 4953.133201689708, 4966.87582810429, 4990.451050384455, 5006.974965125151, 4402.207602631525, 4420.58004489573, 4431.7784110794655, 4434.955650443519, 4469.150861336336, 6074.388013154342, 6086.665233412161, 6148.692565371758, 6180.351063138396, 6186.690665466709, 5737.282839645044, 5748.252727145445, 5762.308522977228, 5781.248437703071, 5792.362840087587, 6473.44975677068, 6575.0, 6644.136262285921, 6644.269130395653, 6662.267150613428, 4803.471618122004, 4838.395200599925, 4861.246506791453, 4865.781039853215, 4880.1703710368965, 6965.477589180831, 7023.33278338557, 7071.151461824614, 7088.015355700412, 7097.89353159703, 4970.751462426936, 4987.276844857475, 5011.949880501148, 5015.423226328946, 5029.346184995927, 5012.972340670154, 5055.418626857959, 5075.42661774851, 5079.6698214615935, 5086.491350864958, 5650.632708873993, 5730.455606717355, 5733.455321744427, 5749.1663708762, 5784.3926387729525, 6469.644169570624, 6569.142423045991, 6594.7032383542855, 6599.769008084694, 6765.255821859591, 1666.9166541672869, 1669.72449545826, 1715.7254839225914, 1753.9210735516933, 1761.110639127258, 1202.8977536909285, 1206.390772659801, 1207.2394391533278, 1210.0138387214568, 1223.9388030598434, 5751.827445176651, 5769.740361683735, 5791.333996590446, 5841.452015215971, 5857.464695862454, 6582.670866456658, 6600.73597056122, 6737.764178253738, 6809.0, 6823.795286141423, 5739.655620662774, 5794.783095549982, 5813.56398270123, 5821.53427725781, 5834.562407819346, 3591.299696559146, 3666.6150054244454, 3667.94498082529, 3672.779633222015, 3678.3930651442747, 6563.737450502022, 6589.736410543621, 6618.768343108064, 6650.935850263934, 6665.100211471389, 6968.860622787516, 7027.648617569101, 7039.416131370401, 7079.398251148607, 7099.757542430054, 6473.838154046187, 6540.901886471706, 6542.0, 6542.967285163544, 6614.338566143443, 6779.186497620317, 6783.864322713617, 6843.315668433117, 6894.172699276119, 6899.137607799025, 6656.5340426169705, 6713.1944166700305, 6762.86474270502, 6775.0, 6794.233499290319, 6555.672216389257, 6592.43964263043, 6671.499637527302, 6694.732210711517, 6710.362515561014, 4914.778834952507, 4945.950540494549, 4962.255661650781, 4979.950200497949, 5014.4484106747495, 6806.489513286622, 6837.470136049495, 6841.452683785185, 6857.931420685929, 6860.862782744417, 6569.835754106186, 6569.9014514783275, 6576.2766095730385, 6595.604263744191, 6611.30581288977, 6507.479401647762, 6516.902246466212, 6575.829976107777, 6638.17022872141, 6657.53397262187, 6182.567220294536, 6344.968275158594, 6350.809475715736, 6453.0, 6548.410643042149, 6151.907721384094, 6489.513286503626, 6553.836154095995, 6578.618490117129, 6618.974059020859, 6253.0, 6270.467010304175, 6338.619682819046, 6382.712777925098, 6441.291457939529], "value": 5078.894998245722, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [911.184489881556, 919.1681528216964, 928.0580211085745, 930.1953809954383, 949.1125797379449, 17810.465686029438, 17957.0, 18960.146793394295, 18976.525586860334, 18984.145713442893, 20771.273005444775, 21483.67774483384, 21671.45821354467, 21703.34889953304, 21813.67279490809, 1003.2024540490328, 1051.7318083888597, 1055.2982266792574, 1061.1298735037235, 1061.6974162363729, 1056.614335767447, 1058.3279617442902, 1069.6737495064003, 1069.7165251208437, 1070.1064611049783, 1072.6621114348993, 1119.8544189255385, 1120.9607663731772, 1121.8822023687517, 1126.1553834624033, 1089.7657003744232, 1098.1489345757063, 1103.911687065041, 1108.501174471487, 1108.9279196852178, 791.3906292155066, 793.7896457438783, 796.8844517544924, 797.1351084073787, 797.1948332184535, 17450.214740336716, 17815.821841781544, 19223.90388048051, 19337.0, 19365.709514357295, 19402.12690428934, 20379.490512737153, 20759.5848083039, 20764.68852967207, 20803.0, 14569.490067847575, 14588.270586470633, 14636.853631463762, 14830.851691483163, 14842.109473431628, 3328.900132996014, 3381.3744457275484, 3392.6776956189124, 3393.4570468725133, 3396.3377141457427, 123117.38441307825, 127117.0, 129485.0, 130716.0, 131777.0, 15770.211489425712, 15977.520674379788, 16162.272697728631, 16174.75737863933, 16190.43333483346, 30205.0, 30215.244618884703, 30252.84873575618, 30323.090307290815, 30385.544216836766, 7613.733519326797, 8502.574871256536, 8809.251213646783, 8823.55882205887, 8863.069377715246, 4117.279476091672, 4223.767692776865, 4226.535081141072, 4273.572642735701, 4424.7123936944, 5201.661891977009, 5354.491323324278, 5355.277037599952, 5364.409914909357, 5364.946350536523, 1057.4554104636118, 1089.0525243038448, 1098.505672447386, 1104.6244276945877, 1106.546316010448, 672.6166085331314, 674.9257581666013, 689.3726708695064, 710.6233696141054, 714.9714011439588, 11833.408329583659, 12489.93755031219, 13816.0, 13966.301684915714, 14005.439782408794, 672.364615438406, 699.9720011199597, 700.9649517524103, 704.9224585295614, 713.2332742301942, 5209.453007434241, 5674.659520428788, 5683.9874866320915, 5757.309122905278, 5796.188533605215, 104876.47561762143, 107412.0, 108092.45953770338, 110409.0, 114451.0, 89476.55261723649, 94096.52951735197, 97180.0, 97524.0, 99177.0, 78522.0, 80589.59705201436, 80949.0, 81335.0, 82649.0, 9845.950770246389, 10450.529726162189, 10645.361278323326, 11624.302541847515, 12686.238825670489, 33946.49080263748, 35969.0, 36528.44300898912, 37438.6256137446, 39408.21183576255, 66002.0546783813, 66070.0, 68424.0, 68986.65506672434, 74134.0, 19483.025848707224, 19499.70750438773, 19707.211711531952, 19708.50728731793, 20011.699824502935, 20986.47533811606, 21243.256486022914, 21463.678044829026, 22010.0, 22254.443638909157, 18886.244550217838, 19362.0, 19566.21735130579, 19567.315143969892, 19803.10886010162, 18080.276788928295, 18498.722519162493, 18667.719984199975, 18944.242230310632, 18957.526061848013, 18498.81501184971, 18668.533286667942, 18688.25246990105, 18948.0, 19156.137973790934, 12046.277223366626, 12724.0, 13667.931660341636, 13748.587542373745, 14321.64195895111, 13895.166290022631, 14770.48303309379, 15065.397384104514, 15080.54758357251, 15554.688906222038], "value": 9193.644828790522, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 112.0, 100.0, 109.0, 110.0, 114.0, 108.0, 105.0, 111.0, 111.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 123.0, 144.0, 178.0, 118.0, 145.0, 145.0, 118.0, 178.0, 118.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 162.0, 162.0, 161.0, 163.0, 164.0, 161.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 76.0, 180.0, 75.0, 75.0, 76.0, 86.0, 96.0, 75.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 142.0, 81.0, 79.0, 83.0, 132.0, 80.0, 78.0, 137.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 117.0, 113.0, 117.0, 115.0, 114.0, 115.0, 114.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 151.0, 151.0, 150.0, 152.0, 153.0, 155.0, 159.0, 152.0], "value": 152.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 97.0, 94.0, 95.0, 94.0, 100.0, 93.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 62.0, 54.0, 53.0, 54.0, 54.0, 57.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 54.0, 58.0, 61.0, 61.0, 60.0, 66.0, 54.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 90.0, 77.0, 94.0, 80.0, 77.0, 76.0, 97.0, 78.0, 92.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 142.0, 134.0, 132.0, 141.0, 130.0, 123.0, 124.0, 127.0, 162.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 178.0, 183.0, 177.0, 180.0, 173.0, 174.0, 173.0, 179.0, 174.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 73.0, 69.0, 67.0, 65.0, 69.0, 64.0, 66.0, 72.0], "value": 68.0, "unit": "score"}]}]} 14:28:09 INFO - Return code: 0 14:28:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:28:09 INFO - # TBPL SUCCESS # 14:28:09 INFO - Running post-action listener: _package_coverage_data 14:28:09 INFO - Running post-action listener: _resource_record_post_action 14:28:09 INFO - [mozharness: 2017-08-01 21:28:09.923133Z] Finished run-tests step (success) 14:28:09 INFO - Running post-run listener: _resource_record_post_run 14:28:10 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 434794496; Read time: 16; Write time: 299536 14:28:10 INFO - TinderboxPrint: CPU usage
13.2% 14:28:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 14:28:10 INFO - TinderboxPrint: I/O write bytes / time
434,794,496 / 299,536 14:28:10 INFO - TinderboxPrint: CPU idle
8,272.9 (86.8%) 14:28:10 INFO - TinderboxPrint: CPU user
1,206.0 (12.7%) 14:28:10 INFO - TinderboxPrint: Swap in / out
0 / 0 14:28:10 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 110321664; Read time: 0; Write time: 96780 14:28:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:28:10 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 324472832; Read time: 0; Write time: 202756 14:28:10 INFO - Running post-run listener: _upload_blobber_files 14:28:10 INFO - Blob upload gear active. 14:28:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:28:10 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 14:28:10 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'] 14:28:10 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 14:28:10 INFO - (blobuploader) - INFO - Open directory for files ... 14:28:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:28:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:28:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:11 INFO - (blobuploader) - INFO - Done attempting. 14:28:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:28:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:28:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:19 INFO - (blobuploader) - INFO - Done attempting. 14:28:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:28:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:28:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:20 INFO - (blobuploader) - INFO - Done attempting. 14:28:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:28:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:28:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:28:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:28:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:28:20 INFO - (blobuploader) - INFO - Done attempting. 14:28:20 INFO - (blobuploader) - INFO - Iteration through files over. 14:28:20 INFO - Return code: 0 14:28:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:28:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:28:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffb600e87d2f2d21f04aaa8292f5a6156ff60e066c415f5ab94d494c80f8534723ae7397ca550ec14519eced6d4cfd71d5d66f564503ab1bbc673369094d64fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32ae26fbd9439ee2ec69c9e7d615635a7b75c9ef2886f53c81a9755f2fd2387ef3cc47f398517debce765a57e0cea186d525507f451fa05eaedcb263f8d0592d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017be266450ccddda0dd66653084afae0f3ad9b762139a38305a80ff4934920345e469edd11d489dc07d9a70dd152c2a13de214dc9ff3a20e22b98a52d9d7a3f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5981ea0fe7e7e93fcd9259a3097d1be62e0fbfa5002fdfa71b5bbbd3858f5c9f1472d0374d718ae8a6f6fb4b3529524fb1a2ce59d204e336379810c79a537ff2"} 14:28:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:28:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:28:20 INFO - Contents: 14:28:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffb600e87d2f2d21f04aaa8292f5a6156ff60e066c415f5ab94d494c80f8534723ae7397ca550ec14519eced6d4cfd71d5d66f564503ab1bbc673369094d64fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32ae26fbd9439ee2ec69c9e7d615635a7b75c9ef2886f53c81a9755f2fd2387ef3cc47f398517debce765a57e0cea186d525507f451fa05eaedcb263f8d0592d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017be266450ccddda0dd66653084afae0f3ad9b762139a38305a80ff4934920345e469edd11d489dc07d9a70dd152c2a13de214dc9ff3a20e22b98a52d9d7a3f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5981ea0fe7e7e93fcd9259a3097d1be62e0fbfa5002fdfa71b5bbbd3858f5c9f1472d0374d718ae8a6f6fb4b3529524fb1a2ce59d204e336379810c79a537ff2"} 14:28:20 INFO - Running post-run listener: copy_logs_to_upload_dir 14:28:20 INFO - Copying logs to upload dir... 14:28:20 INFO - mkdir: /builds/slave/test/build/upload/logs 14:28:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.006287 ========= master_lag: -0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-01 14:28:20.605069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 14:28:20.609817) ========= 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=db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffb600e87d2f2d21f04aaa8292f5a6156ff60e066c415f5ab94d494c80f8534723ae7397ca550ec14519eced6d4cfd71d5d66f564503ab1bbc673369094d64fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32ae26fbd9439ee2ec69c9e7d615635a7b75c9ef2886f53c81a9755f2fd2387ef3cc47f398517debce765a57e0cea186d525507f451fa05eaedcb263f8d0592d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017be266450ccddda0dd66653084afae0f3ad9b762139a38305a80ff4934920345e469edd11d489dc07d9a70dd152c2a13de214dc9ff3a20e22b98a52d9d7a3f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5981ea0fe7e7e93fcd9259a3097d1be62e0fbfa5002fdfa71b5bbbd3858f5c9f1472d0374d718ae8a6f6fb4b3529524fb1a2ce59d204e336379810c79a537ff2"} build_url:https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffb600e87d2f2d21f04aaa8292f5a6156ff60e066c415f5ab94d494c80f8534723ae7397ca550ec14519eced6d4cfd71d5d66f564503ab1bbc673369094d64fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32ae26fbd9439ee2ec69c9e7d615635a7b75c9ef2886f53c81a9755f2fd2387ef3cc47f398517debce765a57e0cea186d525507f451fa05eaedcb263f8d0592d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017be266450ccddda0dd66653084afae0f3ad9b762139a38305a80ff4934920345e469edd11d489dc07d9a70dd152c2a13de214dc9ff3a20e22b98a52d9d7a3f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5981ea0fe7e7e93fcd9259a3097d1be62e0fbfa5002fdfa71b5bbbd3858f5c9f1472d0374d718ae8a6f6fb4b3529524fb1a2ce59d204e336379810c79a537ff2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 14:28:20.636994) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:28:20.637322) ========= 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=db0483c52d987ecb441a263b000001ad-1501621642.115466-1007911648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:28:20.719429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 14:28:20.719754) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 14:28:20.720037) ========= ========= Total master_lag: -0.12 =========