builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1507106850.3 results: success (0) revision: 3f97c1571aac47968c562f066ffbffe9ff23425f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 01:47:30.304804) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-04 01:47:30.305323) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 01:47:30.305613) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-04 01:47:30.352015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 01:47:30.352403) ========= 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=923d835db2ba3686ebe126b700000192-1507086409.818686-525191384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-04 01:47:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.9M=0s 2017-10-04 01:47:30 (25.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168779 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 01:47:30.554804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 01:47:30.555149) ========= 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=923d835db2ba3686ebe126b700000192-1507086409.818686-525191384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.073888 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 01:47:30.645418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-10-04 01:47:30.645910) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3f97c1571aac47968c562f066ffbffe9ff23425f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 3f97c1571aac47968c562f066ffbffe9ff23425f --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=923d835db2ba3686ebe126b700000192-1507086409.818686-525191384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-04 01:47:30,813 truncating revision to first 12 chars 2017-10-04 01:47:30,813 Setting DEBUG logging. 2017-10-04 01:47:30,813 attempt 1/10 2017-10-04 01:47:30,813 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/3f97c1571aac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-04 01:47:32,276 unpacking tar archive at: mozilla-beta-3f97c1571aac/testing/mozharness/ program finished with exit code 0 elapsedTime=2.120593 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-10-04 01:47:32.781960) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 01:47:32.782311) ========= script_repo_revision: 3f97c1571aac47968c562f066ffbffe9ff23425f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-04 01:47:32.782714) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 01:47:32.782996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-04 01:47:32.795590) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-10-04 01:47:32.796003) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1507086409.818686-525191384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:47:33 INFO - MultiFileLogger online at 20171004 01:47:33 in /builds/slave/test 01:47:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 01:47:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:47:33 INFO - {'append_to_log': False, 01:47:33 INFO - 'base_work_dir': '/builds/slave/test', 01:47:33 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 01:47:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:47:33 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 01:47:33 INFO - 'buildbot_json_path': 'buildprops.json', 01:47:33 INFO - 'code_coverage': False, 01:47:33 INFO - 'config_files': ('talos/linux_config.py',), 01:47:33 INFO - 'default_actions': ('clobber', 01:47:33 INFO - 'read-buildbot-config', 01:47:33 INFO - 'download-and-extract', 01:47:33 INFO - 'populate-webroot', 01:47:33 INFO - 'create-virtualenv', 01:47:33 INFO - 'install', 01:47:33 INFO - 'setup-mitmproxy', 01:47:33 INFO - 'run-tests'), 01:47:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:47:33 INFO - 'disable_ccov_upload': False, 01:47:33 INFO - 'disable_stylo': False, 01:47:33 INFO - 'download_minidump_stackwalk': True, 01:47:33 INFO - 'download_symbols': 'ondemand', 01:47:33 INFO - 'enable_stylo': False, 01:47:33 INFO - 'enable_webrender': False, 01:47:33 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 01:47:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:47:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:47:33 INFO - 'gecko_profile': False, 01:47:33 INFO - 'gecko_profile_interval': 0, 01:47:33 INFO - 'installer_path': 'installer.exe', 01:47:33 INFO - 'log_level': 'info', 01:47:33 INFO - 'log_name': 'talos', 01:47:33 INFO - 'log_to_console': True, 01:47:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:47:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:47:33 INFO - 'opt_config_files': (), 01:47:33 INFO - 'pip_index': False, 01:47:33 INFO - 'suite': 'dromaeojs-e10s', 01:47:33 INFO - 'system_bits': '32', 01:47:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:47:33 INFO - 'title': 'talos-linux64-ix-007', 01:47:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:47:33 INFO - 'use_talos_json': True, 01:47:33 INFO - 'verify': 'False', 01:47:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:47:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:47:33 INFO - 'work_dir': 'build'} 01:47:33 INFO - [mozharness: 2017-10-04 08:47:33.207456Z] Running clobber step. 01:47:33 INFO - Running pre-action listener: _resource_record_pre_action 01:47:33 INFO - Running main action method: clobber 01:47:33 INFO - rmtree: /builds/slave/test/build 01:47:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:47:35 INFO - Running post-action listener: _resource_record_post_action 01:47:35 INFO - [mozharness: 2017-10-04 08:47:35.053498Z] Finished clobber step (success) 01:47:35 INFO - [mozharness: 2017-10-04 08:47:35.053614Z] Running read-buildbot-config step. 01:47:35 INFO - Running pre-action listener: _resource_record_pre_action 01:47:35 INFO - Running main action method: read_buildbot_config 01:47:35 INFO - Using buildbot properties: 01:47:35 INFO - { 01:47:35 INFO - "project": "", 01:47:35 INFO - "product": "firefox", 01:47:35 INFO - "who": "ffxbld@noreply.mozilla.org", 01:47:35 INFO - "installer_path": "public/build/target.tar.bz2", 01:47:35 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 01:47:35 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 01:47:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 01:47:35 INFO - "stage_platform": "linux64", 01:47:35 INFO - "basedir": "/builds/slave/test", 01:47:35 INFO - "buildnumber": 125, 01:47:35 INFO - "platform": "ubuntu64_hw", 01:47:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:47:35 INFO - "slavebuilddir": "test", 01:47:35 INFO - "taskId": "eB2qxITXRpWR-AwldY65jg", 01:47:35 INFO - "branch": "mozilla-beta", 01:47:35 INFO - "script_repo_revision": "production", 01:47:35 INFO - "revision": "3f97c1571aac47968c562f066ffbffe9ff23425f", 01:47:35 INFO - "slavename": "talos-linux64-ix-007", 01:47:35 INFO - "repo_path": "releases/mozilla-beta" 01:47:35 INFO - } 01:47:35 INFO - Finding installer, test and symbols from parent task. 01:47:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eB2qxITXRpWR-AwldY65jg'}, attempt #1 01:47:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eB2qxITXRpWR-AwldY65jg'}, attempt #1 01:47:36 INFO - Task dependencies: aszCTdw9TAurduR-fLv3-w 01:47:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w'}, attempt #1 01:47:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.tar.bz2 01:47:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.test_packages.json 01:47:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.crashreporter-symbols.zip 01:47:36 INFO - Running post-action listener: _resource_record_post_action 01:47:36 INFO - [mozharness: 2017-10-04 08:47:36.895610Z] Finished read-buildbot-config step (success) 01:47:36 INFO - [mozharness: 2017-10-04 08:47:36.895832Z] Running download-and-extract step. 01:47:36 INFO - Running pre-action listener: _resource_record_pre_action 01:47:36 INFO - Running main action method: download_and_extract 01:47:36 INFO - mkdir: /builds/slave/test/build/tests 01:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:47:36 INFO - trying https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.test_packages.json 01:47:36 INFO - Downloading https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:47:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:47:37 INFO - Downloaded 989 bytes. 01:47:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:47:37 INFO - Using the following test package requirements: 01:47:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 01:47:37 INFO - u'common': [u'target.common.tests.zip'], 01:47:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:47:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:47:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:47:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:47:37 INFO - u'mozbase': [u'target.common.tests.zip'], 01:47:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:47:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:47:37 INFO - u'web-platform': [u'target.common.tests.zip', 01:47:37 INFO - u'target.web-platform.tests.tar.gz'], 01:47:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:47:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 01:47:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.common.tests.zip 01:47:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:47:37 INFO - Fetch https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.common.tests.zip into memory 01:47:38 INFO - Content-Length response header: 55185935 01:47:38 INFO - Bytes received: 55185935 01:47:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.talos.tests.zip 01:47:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:47:49 INFO - Fetch https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.talos.tests.zip into memory 01:47:49 INFO - Content-Length response header: 14509184 01:47:49 INFO - Bytes received: 14509184 01:47:50 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')]} 01:47:50 INFO - trying https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.tar.bz2 01:47:50 INFO - Downloading https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:47:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:47:52 INFO - Downloaded 53526777 bytes. 01:47:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.tar.bz2 01:47:52 INFO - mkdir: /builds/slave/test/properties 01:47:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:47:52 INFO - Writing to file /builds/slave/test/properties/build_url 01:47:52 INFO - Contents: 01:47:52 INFO - build_url:https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.tar.bz2 01:47:52 INFO - Running post-action listener: _resource_record_post_action 01:47:52 INFO - Running post-action listener: find_tests_for_verification 01:47:52 INFO - Running post-action listener: set_extra_try_arguments 01:47:52 INFO - [mozharness: 2017-10-04 08:47:52.269159Z] Finished download-and-extract step (success) 01:47:52 INFO - [mozharness: 2017-10-04 08:47:52.269258Z] Running populate-webroot step. 01:47:52 INFO - Running pre-action listener: _resource_record_pre_action 01:47:52 INFO - Running main action method: populate_webroot 01:47:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:47:52 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:47:52 INFO - 'tests': ['tresize', 01:47:52 INFO - 'tcanvasmark']}, 01:47:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:47:52 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:47:52 INFO - 'tests': ['dromaeo_css', 01:47:52 INFO - 'kraken']}, 01:47:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:47:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:47:52 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:47:52 INFO - 'talos_options': ['--disable-stylo'], 01:47:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:47:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:47:52 INFO - 'tests': ['damp', 'tps']}, 01:47:52 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:47:52 INFO - 'talos_options': ['--disable-stylo'], 01:47:52 INFO - 'tests': ['damp', 'tps']}, 01:47:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:47:52 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:47:52 INFO - 'tests': ['dromaeo_dom']}, 01:47:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 01:47:52 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:47:52 INFO - 'tests': ['basic_compositor_video', 01:47:52 INFO - 'glvideo']}, 01:47:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 01:47:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 01:47:52 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:47:52 INFO - 'talos_options': ['--disable-stylo'], 01:47:52 INFO - 'tests': ['ts_paint_webext', 01:47:52 INFO - 'tp5o_webext']}, 01:47:52 INFO - 'other-e10s': {'tests': ['a11yr', 01:47:52 INFO - 'ts_paint', 01:47:52 INFO - 'tpaint', 01:47:52 INFO - 'sessionrestore', 01:47:52 INFO - 'sessionrestore_many_windows', 01:47:52 INFO - 'sessionrestore_no_auto_restore', 01:47:52 INFO - 'tabpaint']}, 01:47:52 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:47:52 INFO - 'tests': ['a11yr', 01:47:52 INFO - 'ts_paint', 01:47:52 INFO - 'tpaint', 01:47:52 INFO - 'sessionrestore', 01:47:52 INFO - 'sessionrestore_many_windows', 01:47:52 INFO - 'sessionrestore_no_auto_restore', 01:47:52 INFO - 'tabpaint']}, 01:47:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 01:47:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 01:47:52 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:47:52 INFO - 'tests': ['perf_reftest_singletons']}, 01:47:52 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:47:52 INFO - 'tests': ['bloom_basic']}, 01:47:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:47:52 INFO - 'tsvgr_opacity', 01:47:52 INFO - 'tart', 01:47:52 INFO - 'tscrollx', 01:47:52 INFO - 'tsvg_static']}, 01:47:52 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 01:47:52 INFO - 'tests': ['tsvgx', 01:47:52 INFO - 'tsvgr_opacity', 01:47:52 INFO - 'tart', 01:47:52 INFO - 'tscrollx', 01:47:52 INFO - 'tsvg_static']}, 01:47:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:47:52 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:47:52 INFO - 'talos_options': ['--disable-stylo'], 01:47:52 INFO - 'tests': ['tp5o']}, 01:47:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:47:52 INFO - 'talos_options': ['--mitmproxy', 01:47:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:47:52 INFO - '--firstNonBlankPaint'], 01:47:52 INFO - 'tests': ['tp6_google', 01:47:52 INFO - 'tp6_youtube', 01:47:52 INFO - 'tp6_amazon', 01:47:52 INFO - 'tp6_facebook']}, 01:47:52 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:47:52 INFO - 'talos_options': ['--disable-stylo', 01:47:52 INFO - '--mitmproxy', 01:47:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:47:52 INFO - '--firstNonBlankPaint'], 01:47:52 INFO - 'tests': ['tp6_google', 01:47:52 INFO - 'tp6_youtube', 01:47:52 INFO - 'tp6_amazon', 01:47:52 INFO - 'tp6_facebook']}, 01:47:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 01:47:52 INFO - 'talos_options': ['--stylo-threads=1', 01:47:52 INFO - '--mitmproxy', 01:47:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 01:47:52 INFO - '--firstNonBlankPaint'], 01:47:52 INFO - 'tests': ['tp6_google', 01:47:52 INFO - 'tp6_youtube', 01:47:52 INFO - 'tp6_amazon', 01:47:52 INFO - 'tp6_facebook']}, 01:47:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:47:52 INFO - 'talos_options': ['--xperf_path', 01:47:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:47:52 INFO - 'tests': ['tp5n']}, 01:47:52 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 01:47:52 INFO - 'talos_options': ['--disable-stylo', 01:47:52 INFO - '--xperf_path', 01:47:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:47:52 INFO - 'tests': ['tp5n']}}} 01:47:52 INFO - Running post-action listener: _resource_record_post_action 01:47:52 INFO - [mozharness: 2017-10-04 08:47:52.284306Z] Finished populate-webroot step (success) 01:47:52 INFO - [mozharness: 2017-10-04 08:47:52.284396Z] Running create-virtualenv step. 01:47:52 INFO - Running pre-action listener: _resource_record_pre_action 01:47:52 INFO - Running main action method: create_virtualenv 01:47:52 INFO - Creating virtualenv /builds/slave/test/build/venv 01:47:52 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:47:52 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 01:47:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 01:47:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:47:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:47:53 INFO - Installing distribute.............................................................................................................................................................................................done. 01:47:53 INFO - Installing pip...............done. 01:47:53 INFO - Return code: 0 01:47:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:47:53 INFO - Reading from file tmpfile_stdout 01:47:53 INFO - Output received: 01:47:53 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 01:47:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:47: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')]} 01:47:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47: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')]} 01:47:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:53 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 0x12f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1663a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667090>, '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 0x1667d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1661f90>, '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': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', '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 01:47:53 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 01:47:53 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 01:47:53 INFO - Using env: {'DISPLAY': ':0', 01:47:53 INFO - 'HOME': '/home/cltbld', 01:47:53 INFO - 'LANG': 'en_US.UTF-8', 01:47:53 INFO - 'LANGUAGE': 'en_US:en', 01:47:53 INFO - 'LOGNAME': 'cltbld', 01:47:53 INFO - 'MAIL': '/var/mail/cltbld', 01:47:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:53 INFO - 'MOZ_NO_REMOTE': '1', 01:47:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:53 INFO - 'NO_EM_RESTART': '1', 01:47:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:53 INFO - 'PWD': '/builds/slave/test', 01:47:53 INFO - 'SHELL': '/bin/bash', 01:47:53 INFO - 'SHLVL': '1', 01:47:53 INFO - 'TERM': 'linux', 01:47:53 INFO - 'TMOUT': '86400', 01:47:53 INFO - 'USER': 'cltbld', 01:47:53 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', 01:47:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:53 INFO - '_': '/tools/buildbot/bin/python'} 01:47:54 INFO - Ignoring indexes: http://pypi.python.org/simple/ 01:47:54 INFO - Downloading/unpacking pip>=1.5 01:47:54 INFO - Running setup.py egg_info for package pip 01:47:54 INFO - warning: no files found matching 'pip/cacert.pem' 01:47:54 INFO - warning: no files found matching '*.html' under directory 'docs' 01:47:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 01:47:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 01:47:54 INFO - Installing collected packages: pip 01:47:54 INFO - Found existing installation: pip 1.1 01:47:54 INFO - Uninstalling pip: 01:47:54 INFO - Successfully uninstalled pip 01:47:54 INFO - Running setup.py install for pip 01:47:54 INFO - warning: no files found matching 'pip/cacert.pem' 01:47:54 INFO - warning: no files found matching '*.html' under directory 'docs' 01:47:54 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 01:47:54 INFO - no previously-included directories found matching 'docs/_build/_sources' 01:47:54 INFO - Installing pip script to /builds/slave/test/build/venv/bin 01:47:54 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 01:47:54 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 01:47:54 INFO - Successfully installed pip 01:47:54 INFO - Cleaning up... 01:47:54 INFO - Return code: 0 01:47:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:47:54 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')]} 01:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:54 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')]} 01:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:54 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 0x12f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1663a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667090>, '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 0x1667d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1661f90>, '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': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', '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 01:47:54 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 01:47:54 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 01:47:54 INFO - Using env: {'DISPLAY': ':0', 01:47:54 INFO - 'HOME': '/home/cltbld', 01:47:54 INFO - 'LANG': 'en_US.UTF-8', 01:47:54 INFO - 'LANGUAGE': 'en_US:en', 01:47:54 INFO - 'LOGNAME': 'cltbld', 01:47:54 INFO - 'MAIL': '/var/mail/cltbld', 01:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:54 INFO - 'MOZ_NO_REMOTE': '1', 01:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:54 INFO - 'NO_EM_RESTART': '1', 01:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:54 INFO - 'PWD': '/builds/slave/test', 01:47:54 INFO - 'SHELL': '/bin/bash', 01:47:54 INFO - 'SHLVL': '1', 01:47:54 INFO - 'TERM': 'linux', 01:47:54 INFO - 'TMOUT': '86400', 01:47:54 INFO - 'USER': 'cltbld', 01:47:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', 01:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:54 INFO - '_': '/tools/buildbot/bin/python'} 01:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:55 INFO - Downloading/unpacking psutil>=3.1.1 01:47:55 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 01:47:55 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 01:47:55 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 01:47:55 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 01:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:47:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:47:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:47:56 INFO - Installing collected packages: psutil 01:47:56 INFO - Running setup.py install for psutil 01:47:56 INFO - building 'psutil._psutil_linux' extension 01:47:56 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 01:47:58 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 01:47:58 INFO - building 'psutil._psutil_posix' extension 01:47:58 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 01:47:58 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 01:47:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:47:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:47:58 INFO - Successfully installed psutil 01:47:58 INFO - Cleaning up... 01:47:58 INFO - Return code: 0 01:47:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:47:58 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')]} 01:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:58 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')]} 01:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:58 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 0x12f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1663a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667090>, '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 0x1667d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1661f90>, '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': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', '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 01:47:58 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 01:47:58 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 01:47:58 INFO - Using env: {'DISPLAY': ':0', 01:47:58 INFO - 'HOME': '/home/cltbld', 01:47:58 INFO - 'LANG': 'en_US.UTF-8', 01:47:58 INFO - 'LANGUAGE': 'en_US:en', 01:47:58 INFO - 'LOGNAME': 'cltbld', 01:47:58 INFO - 'MAIL': '/var/mail/cltbld', 01:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:58 INFO - 'MOZ_NO_REMOTE': '1', 01:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:58 INFO - 'NO_EM_RESTART': '1', 01:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:58 INFO - 'PWD': '/builds/slave/test', 01:47:58 INFO - 'SHELL': '/bin/bash', 01:47:58 INFO - 'SHLVL': '1', 01:47:58 INFO - 'TERM': 'linux', 01:47:58 INFO - 'TMOUT': '86400', 01:47:58 INFO - 'USER': 'cltbld', 01:47:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', 01:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:58 INFO - '_': '/tools/buildbot/bin/python'} 01:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:47: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 01:47: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 01:47: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 01:47: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 01:47:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:47:59 INFO - Installing collected packages: mozsystemmonitor 01:47:59 INFO - Running setup.py install for mozsystemmonitor 01:47:59 INFO - Successfully installed mozsystemmonitor 01:47:59 INFO - Cleaning up... 01:47:59 INFO - Return code: 0 01:47:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:47: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')]} 01:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47: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')]} 01:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47: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', '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 0x12f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1663a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667090>, '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 0x1667d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1661f90>, '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': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', '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 01:47: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:47: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 jsonschema==2.5.1 01:47:59 INFO - Using env: {'DISPLAY': ':0', 01:47:59 INFO - 'HOME': '/home/cltbld', 01:47:59 INFO - 'LANG': 'en_US.UTF-8', 01:47:59 INFO - 'LANGUAGE': 'en_US:en', 01:47:59 INFO - 'LOGNAME': 'cltbld', 01:47:59 INFO - 'MAIL': '/var/mail/cltbld', 01:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:59 INFO - 'MOZ_NO_REMOTE': '1', 01:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:59 INFO - 'NO_EM_RESTART': '1', 01:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:59 INFO - 'PWD': '/builds/slave/test', 01:47:59 INFO - 'SHELL': '/bin/bash', 01:47:59 INFO - 'SHLVL': '1', 01:47:59 INFO - 'TERM': 'linux', 01:47:59 INFO - 'TMOUT': '86400', 01:47:59 INFO - 'USER': 'cltbld', 01:48:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', 01:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:00 INFO - '_': '/tools/buildbot/bin/python'} 01:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:00 INFO - Downloading/unpacking jsonschema==2.5.1 01:48: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 01:48: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 01:48: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 01:48: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 01:48:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:48:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:48: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 01:48: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 01:48: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 01:48: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 01:48:01 INFO - Downloading functools32-3.2.3-2.tar.gz 01:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:48:01 INFO - warning: no files found matching '*.txt' 01:48:01 INFO - no previously-included directories found matching 'build' 01:48:01 INFO - no previously-included directories found matching 'dist' 01:48:01 INFO - no previously-included directories found matching '.git*' 01:48:01 INFO - Installing collected packages: jsonschema, functools32 01:48:01 INFO - Running setup.py install for functools32 01:48:01 INFO - warning: no files found matching '*.txt' 01:48:01 INFO - no previously-included directories found matching 'build' 01:48:01 INFO - no previously-included directories found matching 'dist' 01:48:01 INFO - no previously-included directories found matching '.git*' 01:48:01 INFO - Successfully installed jsonschema functools32 01:48:01 INFO - Cleaning up... 01:48:01 INFO - Return code: 0 01:48:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:48: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')]} 01:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48: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')]} 01:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48: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', '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 0x12f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1663a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667090>, '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 0x1667d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1661f90>, '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': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', '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 01:48: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:48: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 functools32==3.2.3-2 01:48:01 INFO - Using env: {'DISPLAY': ':0', 01:48:01 INFO - 'HOME': '/home/cltbld', 01:48:01 INFO - 'LANG': 'en_US.UTF-8', 01:48:01 INFO - 'LANGUAGE': 'en_US:en', 01:48:01 INFO - 'LOGNAME': 'cltbld', 01:48:01 INFO - 'MAIL': '/var/mail/cltbld', 01:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:01 INFO - 'MOZ_NO_REMOTE': '1', 01:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:01 INFO - 'NO_EM_RESTART': '1', 01:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:01 INFO - 'PWD': '/builds/slave/test', 01:48:01 INFO - 'SHELL': '/bin/bash', 01:48:01 INFO - 'SHLVL': '1', 01:48:01 INFO - 'TERM': 'linux', 01:48:01 INFO - 'TMOUT': '86400', 01:48:01 INFO - 'USER': 'cltbld', 01:48:01 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', 01:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:01 INFO - '_': '/tools/buildbot/bin/python'} 01:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:48:02 INFO - Cleaning up... 01:48:02 INFO - Return code: 0 01:48:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:48: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')]} 01:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48: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')]} 01:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48: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', '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 0x12f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1663a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667090>, '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 0x1667d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1661f90>, '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': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', '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 01:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:48: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 blobuploader==1.2.4 01:48:02 INFO - Using env: {'DISPLAY': ':0', 01:48:02 INFO - 'HOME': '/home/cltbld', 01:48:02 INFO - 'LANG': 'en_US.UTF-8', 01:48:02 INFO - 'LANGUAGE': 'en_US:en', 01:48:02 INFO - 'LOGNAME': 'cltbld', 01:48:02 INFO - 'MAIL': '/var/mail/cltbld', 01:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:02 INFO - 'MOZ_NO_REMOTE': '1', 01:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:02 INFO - 'NO_EM_RESTART': '1', 01:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:02 INFO - 'PWD': '/builds/slave/test', 01:48:02 INFO - 'SHELL': '/bin/bash', 01:48:02 INFO - 'SHLVL': '1', 01:48:02 INFO - 'TERM': 'linux', 01:48:02 INFO - 'TMOUT': '86400', 01:48:02 INFO - 'USER': 'cltbld', 01:48:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', 01:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:02 INFO - '_': '/tools/buildbot/bin/python'} 01:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:02 INFO - Downloading/unpacking blobuploader==1.2.4 01:48: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 01:48: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 01:48: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 01:48: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 01:48:03 INFO - Downloading blobuploader-1.2.4.tar.gz 01:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:48:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:48: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 01:48: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 01:48: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 01:48: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 01:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:48:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:48: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 01:48: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 01:48: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 01:48: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 01:48:03 INFO - Downloading docopt-0.6.1.tar.gz 01:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:48:03 INFO - Installing collected packages: blobuploader, requests, docopt 01:48:03 INFO - Running setup.py install for blobuploader 01:48:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:48:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:48:04 INFO - Running setup.py install for requests 01:48:04 INFO - Running setup.py install for docopt 01:48:04 INFO - Successfully installed blobuploader requests docopt 01:48:04 INFO - Cleaning up... 01:48:04 INFO - Return code: 0 01:48:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:04 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 0x12f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1663a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667090>, '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 0x1667d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1661f90>, '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': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', '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 01:48:04 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 01:48:04 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 01:48:04 INFO - Using env: {'DISPLAY': ':0', 01:48:04 INFO - 'HOME': '/home/cltbld', 01:48:04 INFO - 'LANG': 'en_US.UTF-8', 01:48:04 INFO - 'LANGUAGE': 'en_US:en', 01:48:04 INFO - 'LOGNAME': 'cltbld', 01:48:04 INFO - 'MAIL': '/var/mail/cltbld', 01:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:04 INFO - 'MOZ_NO_REMOTE': '1', 01:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:04 INFO - 'NO_EM_RESTART': '1', 01:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:04 INFO - 'PWD': '/builds/slave/test', 01:48:04 INFO - 'SHELL': '/bin/bash', 01:48:04 INFO - 'SHLVL': '1', 01:48:04 INFO - 'TERM': 'linux', 01:48:04 INFO - 'TMOUT': '86400', 01:48:04 INFO - 'USER': 'cltbld', 01:48:04 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', 01:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:04 INFO - '_': '/tools/buildbot/bin/python'} 01:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:48:04 INFO - Running setup.py (path:/tmp/pip-iZyAMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:48:04 INFO - Running setup.py (path:/tmp/pip-gAzcTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:48:04 INFO - Running setup.py (path:/tmp/pip-FqVSdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:48:04 INFO - Running setup.py (path:/tmp/pip-qKFhgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:48:05 INFO - Running setup.py (path:/tmp/pip-X68D1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:48:05 INFO - Running setup.py (path:/tmp/pip-0uS4SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:48:05 INFO - Running setup.py (path:/tmp/pip-GaXCli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:48:05 INFO - Running setup.py (path:/tmp/pip-Fk7zUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:48:05 INFO - Running setup.py (path:/tmp/pip-B32sYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:48:05 INFO - Running setup.py (path:/tmp/pip-thwgWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:48:05 INFO - Running setup.py (path:/tmp/pip-HTZLVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:48:05 INFO - Running setup.py (path:/tmp/pip-o2ZIjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:48:05 INFO - Running setup.py (path:/tmp/pip-Hp966y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:48:05 INFO - Running setup.py (path:/tmp/pip-owPwrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:05 INFO - Running setup.py (path:/tmp/pip-Jswk8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:48:05 INFO - Running setup.py (path:/tmp/pip-vvJn7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:48:05 INFO - Running setup.py (path:/tmp/pip-7SrHyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:48:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:48:05 INFO - Running setup.py install for manifestparser 01:48:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:48:06 INFO - Running setup.py install for mozcrash 01:48:06 INFO - Running setup.py install for mozdebug 01:48:06 INFO - Running setup.py install for mozdevice 01:48:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:48:06 INFO - Running setup.py install for mozfile 01:48:06 INFO - Running setup.py install for mozhttpd 01:48:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:48:06 INFO - Running setup.py install for mozinfo 01:48:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:48:06 INFO - Running setup.py install for mozInstall 01:48:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:48:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:48:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:48:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:48:06 INFO - Running setup.py install for mozleak 01:48:06 INFO - Running setup.py install for mozlog 01:48:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:48:06 INFO - Running setup.py install for moznetwork 01:48:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:48:07 INFO - Running setup.py install for mozprocess 01:48:07 INFO - Running setup.py install for mozprofile 01:48:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:48:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:48:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:48:07 INFO - Running setup.py install for mozrunner 01:48:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:48:07 INFO - Running setup.py install for mozscreenshot 01:48:07 INFO - Running setup.py install for moztest 01:48:07 INFO - Running setup.py install for mozversion 01:48:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:48:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:48:07 INFO - Cleaning up... 01:48:07 INFO - Return code: 0 01:48:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:07 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')]} 01:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:07 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')]} 01:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:07 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 0x12f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1663a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667090>, '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 0x1667d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1661f90>, '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': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', '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 01:48:07 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 01:48:07 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 01:48:07 INFO - Using env: {'DISPLAY': ':0', 01:48:07 INFO - 'HOME': '/home/cltbld', 01:48:07 INFO - 'LANG': 'en_US.UTF-8', 01:48:07 INFO - 'LANGUAGE': 'en_US:en', 01:48:07 INFO - 'LOGNAME': 'cltbld', 01:48:07 INFO - 'MAIL': '/var/mail/cltbld', 01:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:07 INFO - 'MOZ_NO_REMOTE': '1', 01:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:07 INFO - 'NO_EM_RESTART': '1', 01:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:07 INFO - 'PWD': '/builds/slave/test', 01:48:07 INFO - 'SHELL': '/bin/bash', 01:48:07 INFO - 'SHLVL': '1', 01:48:07 INFO - 'TERM': 'linux', 01:48:07 INFO - 'TMOUT': '86400', 01:48:07 INFO - 'USER': 'cltbld', 01:48:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', 01:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:07 INFO - '_': '/tools/buildbot/bin/python'} 01:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:48:07 INFO - Running setup.py (path:/tmp/pip-gs5417-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:48:08 INFO - Running setup.py (path:/tmp/pip-mGvPFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:48:08 INFO - Running setup.py (path:/tmp/pip-tRukyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:48:08 INFO - Running setup.py (path:/tmp/pip-wXz68d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:48:08 INFO - Running setup.py (path:/tmp/pip-jHu9bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:48:08 INFO - Running setup.py (path:/tmp/pip-pxVQyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:48:08 INFO - Running setup.py (path:/tmp/pip-m_9nSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:48:08 INFO - Running setup.py (path:/tmp/pip-eMLJgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:48:08 INFO - Running setup.py (path:/tmp/pip-3x8Zrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:48:08 INFO - Running setup.py (path:/tmp/pip-e8izvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:48:08 INFO - Running setup.py (path:/tmp/pip-YAG7_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:48:08 INFO - Running setup.py (path:/tmp/pip-YqydAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:48:08 INFO - Running setup.py (path:/tmp/pip-Q3l4OQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:48:08 INFO - Running setup.py (path:/tmp/pip-EdpYgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:48:08 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)) 01:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:08 INFO - Running setup.py (path:/tmp/pip-_lee1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:09 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)) 01:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:48:09 INFO - Running setup.py (path:/tmp/pip-b8WQVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:48:09 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)) 01:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:48:09 INFO - Running setup.py (path:/tmp/pip-lJOlnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:48:09 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)) 01:48:09 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)) 01:48:09 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)) 01:48:09 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)) 01:48:09 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)) 01:48:09 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)) 01:48:09 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)) 01:48:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:48:09 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 01:48:09 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 01:48:09 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 01:48:09 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 01:48:10 INFO - Downloading blessings-1.6.tar.gz 01:48:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:48:10 INFO - Installing collected packages: blessings 01:48:10 INFO - Running setup.py install for blessings 01:48:10 INFO - Successfully installed blessings 01:48:10 INFO - Cleaning up... 01:48:10 INFO - Return code: 0 01:48:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:48:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:48:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:48:10 INFO - Reading from file tmpfile_stdout 01:48:10 INFO - Current package versions: 01:48:10 INFO - argparse == 1.2.1 01:48:10 INFO - blessings == 1.6 01:48:10 INFO - blobuploader == 1.2.4 01:48:10 INFO - docopt == 0.6.1 01:48:10 INFO - functools32 == 3.2.3-2 01:48:10 INFO - jsonschema == 2.5.1 01:48:10 INFO - manifestparser == 1.1 01:48:10 INFO - mozInstall == 1.13 01:48:10 INFO - mozcrash == 1.0 01:48:10 INFO - mozdebug == 0.1 01:48:10 INFO - mozdevice == 0.51 01:48:10 INFO - mozfile == 1.2 01:48:10 INFO - mozhttpd == 0.7 01:48:10 INFO - mozinfo == 0.10 01:48:10 INFO - mozleak == 0.1 01:48:10 INFO - mozlog == 3.5 01:48:10 INFO - moznetwork == 0.27 01:48:10 INFO - mozprocess == 0.25 01:48:10 INFO - mozprofile == 0.28 01:48:10 INFO - mozrunner == 6.13 01:48:10 INFO - mozscreenshot == 0.1 01:48:10 INFO - mozsystemmonitor == 0.3 01:48:10 INFO - moztest == 0.8 01:48:10 INFO - mozversion == 1.4 01:48:10 INFO - psutil == 3.1.1 01:48:10 INFO - requests == 1.2.3 01:48:10 INFO - wsgiref == 0.1.2 01:48:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:10 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 0x12f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1663a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667090>, '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 0x1667d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1661f90>, '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': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', '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 01:48:10 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 01:48:10 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 01:48:10 INFO - Using env: {'DISPLAY': ':0', 01:48:10 INFO - 'HOME': '/home/cltbld', 01:48:10 INFO - 'LANG': 'en_US.UTF-8', 01:48:10 INFO - 'LANGUAGE': 'en_US:en', 01:48:10 INFO - 'LOGNAME': 'cltbld', 01:48:10 INFO - 'MAIL': '/var/mail/cltbld', 01:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:10 INFO - 'MOZ_NO_REMOTE': '1', 01:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:10 INFO - 'NO_EM_RESTART': '1', 01:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:10 INFO - 'PWD': '/builds/slave/test', 01:48:10 INFO - 'SHELL': '/bin/bash', 01:48:10 INFO - 'SHLVL': '1', 01:48:10 INFO - 'TERM': 'linux', 01:48:10 INFO - 'TMOUT': '86400', 01:48:10 INFO - 'USER': 'cltbld', 01:48:10 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', 01:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:10 INFO - '_': '/tools/buildbot/bin/python'} 01:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:10 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)) 01:48:10 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)) 01:48:10 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)) 01:48:10 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)) 01:48:10 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)) 01:48:10 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)) 01:48:10 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)) 01:48:10 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)) 01:48:10 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)) 01:48:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 01:48: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 01:48: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 01:48: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 01:48: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 01:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 01:48:12 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)) 01:48:12 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)) 01:48:12 INFO - Installing collected packages: simplejson 01:48:12 INFO - Running setup.py install for simplejson 01:48:12 INFO - building 'simplejson._speedups' extension 01:48:12 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 01:48:13 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 01:48:13 INFO - Successfully installed simplejson 01:48:13 INFO - Cleaning up... 01:48:13 INFO - Return code: 0 01:48:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12f81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1663a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667090>, '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 0x1667d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1661f90>, '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': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', '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 01:48:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:48:13 INFO - Using env: {'DISPLAY': ':0', 01:48:13 INFO - 'HOME': '/home/cltbld', 01:48:13 INFO - 'LANG': 'en_US.UTF-8', 01:48:13 INFO - 'LANGUAGE': 'en_US:en', 01:48:13 INFO - 'LOGNAME': 'cltbld', 01:48:13 INFO - 'MAIL': '/var/mail/cltbld', 01:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:13 INFO - 'MOZ_NO_REMOTE': '1', 01:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:13 INFO - 'NO_EM_RESTART': '1', 01:48:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:13 INFO - 'PWD': '/builds/slave/test', 01:48:13 INFO - 'SHELL': '/bin/bash', 01:48:13 INFO - 'SHLVL': '1', 01:48:13 INFO - 'TERM': 'linux', 01:48:13 INFO - 'TMOUT': '86400', 01:48:13 INFO - 'USER': 'cltbld', 01:48:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', 01:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:13 INFO - '_': '/tools/buildbot/bin/python'} 01:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:48:13 INFO - Cleaning up... 01:48:13 INFO - Return code: 0 01:48:13 INFO - Running post-action listener: _resource_record_post_action 01:48:13 INFO - Running post-action listener: _start_resource_monitoring 01:48:13 INFO - Starting resource monitoring. 01:48:13 INFO - [mozharness: 2017-10-04 08:48:13.432395Z] Finished create-virtualenv step (success) 01:48:13 INFO - [mozharness: 2017-10-04 08:48:13.433332Z] Running install step. 01:48:13 INFO - Running pre-action listener: _resource_record_pre_action 01:48:13 INFO - Running main action method: install 01:48:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:48:13 INFO - Reading from file tmpfile_stdout 01:48:13 INFO - Detecting whether we're running mozinstall >=1.0... 01:48:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:48:13 INFO - Reading from file tmpfile_stdout 01:48:13 INFO - Output received: 01:48:13 INFO - Usage: mozinstall [options] installer 01:48:13 INFO - Options: 01:48:13 INFO - -h, --help show this help message and exit 01:48:13 INFO - -d DEST, --destination=DEST 01:48:13 INFO - Directory to install application into. [default: 01:48:13 INFO - "/builds/slave/test"] 01:48:13 INFO - --app=APP Application being installed. [default: firefox] 01:48:13 INFO - mkdir: /builds/slave/test/build/application 01:48:13 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'] 01:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:48:28 INFO - Reading from file tmpfile_stdout 01:48:28 INFO - Output received: 01:48:28 INFO - /builds/slave/test/build/application/firefox/firefox 01:48:28 INFO - Running post-action listener: _resource_record_post_action 01:48:28 INFO - [mozharness: 2017-10-04 08:48:28.394525Z] Finished install step (success) 01:48:28 INFO - [mozharness: 2017-10-04 08:48:28.394672Z] Running setup-mitmproxy step. 01:48:28 INFO - Running pre-action listener: _resource_record_pre_action 01:48:28 INFO - Running main action method: setup_mitmproxy 01:48:28 INFO - Skipping: mitmproxy is not required 01:48:28 INFO - Running post-action listener: _resource_record_post_action 01:48:28 INFO - [mozharness: 2017-10-04 08:48:28.395719Z] Finished setup-mitmproxy step (success) 01:48:28 INFO - [mozharness: 2017-10-04 08:48:28.395941Z] Running run-tests step. 01:48:28 INFO - Running pre-action listener: _resource_record_pre_action 01:48:28 INFO - Running pre-action listener: _set_gcov_prefix 01:48:28 INFO - Running main action method: run_tests 01:48:28 WARNING - Try message not found. 01:48:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:48:28 INFO - Python 2.7.3 01:48:28 INFO - Return code: 0 01:48:28 INFO - grabbing minidump binary from tooltool 01:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:48:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1667090>, '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 0x1667d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1661f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:48:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:48:28 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:48:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:48:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:48:28 INFO - Return code: 0 01:48:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:48:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:48:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:48:28 INFO - ENV: RUST_BACKTRACE is now full 01:48:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:48:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:48:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 01:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 01:48:28 INFO - Using env: {'DISPLAY': ':0', 01:48:28 INFO - 'HOME': '/home/cltbld', 01:48:28 INFO - 'LANG': 'en_US.UTF-8', 01:48:28 INFO - 'LANGUAGE': 'en_US:en', 01:48:28 INFO - 'LOGNAME': 'cltbld', 01:48:28 INFO - 'MAIL': '/var/mail/cltbld', 01:48:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:48:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:28 INFO - 'MOZ_NO_REMOTE': '1', 01:48:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:28 INFO - 'NO_EM_RESTART': '1', 01:48:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:28 INFO - 'PWD': '/builds/slave/test', 01:48:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:48:28 INFO - 'RUST_BACKTRACE': 'full', 01:48:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:48:28 INFO - 'SHELL': '/bin/bash', 01:48:28 INFO - 'SHLVL': '1', 01:48:28 INFO - 'TERM': 'linux', 01:48:28 INFO - 'TMOUT': '86400', 01:48:28 INFO - 'USER': 'cltbld', 01:48:28 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', 01:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:28 INFO - '_': '/tools/buildbot/bin/python'} 01:48:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 01:48:28 INFO - mozversion application_buildid: 20171004072043 01:48:28 INFO - mozversion application_changeset: 3f97c1571aac47968c562f066ffbffe9ff23425f 01:48:28 INFO - mozversion application_display_name: Firefox 01:48:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:48:28 INFO - mozversion application_name: Firefox 01:48:28 INFO - mozversion application_remotingname: firefox 01:48:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:48:28 INFO - mozversion application_vendor: Mozilla 01:48:28 INFO - mozversion application_version: 57.0 01:48:28 INFO - mozversion platform_buildid: 20171004072043 01:48:28 INFO - mozversion platform_changeset: 3f97c1571aac47968c562f066ffbffe9ff23425f 01:48:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:48:28 INFO - mozversion platform_version: 57.0 01:48:28 INFO - using testdate: 1507106908 01:48:28 INFO - actual date: 1507106908 01:48:28 INFO - starting webserver on 'localhost:47779' 01:48:28 INFO - SUITE-START | Running 2 tests 01:48:28 INFO - TEST-START | dromaeo_css 01:48:28 INFO - Initialising browser for dromaeo_css test... 01:48:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47779/getInfo.html -profile /tmp/tmpQ0QON3/profile 01:48:28 INFO - TEST-INFO | started process 4006 (/builds/slave/test/build/application/firefox/firefox http://localhost:47779/getInfo.html) 01:48:35 INFO - TEST-INFO | 4006: exit 0 01:48:35 INFO - Browser initialized. 01:48:35 INFO - Running cycle 1/1 for dromaeo_css test... 01:48:35 INFO - Using env: {'DISPLAY': ':0', 01:48:35 INFO - 'HOME': '/home/cltbld', 01:48:35 INFO - 'JSGC_DISABLE_POISONING': '1', 01:48:35 INFO - 'LANG': 'en_US.UTF-8', 01:48:35 INFO - 'LANGUAGE': 'en_US:en', 01:48:35 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 01:48:35 INFO - 'LOGNAME': 'cltbld', 01:48:35 INFO - 'MAIL': '/var/mail/cltbld', 01:48:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:48:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:48:35 INFO - 'MOZ_CRASHREPORTER': '1', 01:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:35 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 01:48:35 INFO - 'MOZ_NO_REMOTE': '1', 01:48:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:48:35 INFO - 'NO_EM_RESTART': '1', 01:48:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:35 INFO - 'PWD': '/builds/slave/test', 01:48:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:48:35 INFO - 'RUST_BACKTRACE': 'full', 01:48:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 01:48:35 INFO - 'SHELL': '/bin/bash', 01:48:35 INFO - 'SHLVL': '1', 01:48:35 INFO - 'TERM': 'linux', 01:48:35 INFO - 'TMOUT': '86400', 01:48:35 INFO - 'USER': 'cltbld', 01:48:35 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', 01:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:35 INFO - '_': '/tools/buildbot/bin/python'} 01:48:35 INFO - TEST-INFO | started process 4241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ0QON3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 01:48:36 INFO - PID 4241 | 01:48:36 INFO - PID 4241 | (/builds/slave/test/build/application/firefox/firefox:4290): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 01:48:36 INFO - PID 4241 | 01:48:46 INFO - PID 4241 | RSS: Main: 138244096 01:48:46 INFO - PID 4241 | 01:51:43 INFO - PID 4241 | Cycle 1(1): loaded http://localhost:47779/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47779/tests/dromaeo/cssquery-ext.html) 01:51:44 INFO - PID 4241 | RSS: Main: 145059840 01:51:44 INFO - PID 4241 | 01:54:46 INFO - PID 4241 | Cycle 1(1): loaded http://localhost:47779/tests/dromaeo/cssquery-ext.html (next: http://localhost:47779/tests/dromaeo/cssquery-jquery.html) 01:54:46 INFO - PID 4241 | RSS: Main: 143360000 01:54:46 INFO - PID 4241 | 01:57:48 INFO - PID 4241 | Cycle 1(1): loaded http://localhost:47779/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47779/tests/dromaeo/cssquery-mootools.html) 01:57:48 INFO - PID 4241 | RSS: Main: 145387520 01:57:48 INFO - PID 4241 | 02:00:50 INFO - PID 4241 | Cycle 1(1): loaded http://localhost:47779/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47779/tests/dromaeo/cssquery-prototype.html) 02:00:51 INFO - PID 4241 | RSS: Main: 144867328 02:00:51 INFO - PID 4241 | 02:03:54 INFO - PID 4241 | Cycle 1(1): loaded http://localhost:47779/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47779/tests/dromaeo/cssquery-yui.html) 02:03:54 INFO - PID 4241 | RSS: Main: 146010112 02:03:54 INFO - PID 4241 | 02:06:55 INFO - PID 4241 | Cycle 1(1): loaded http://localhost:47779/tests/dromaeo/cssquery-yui.html (next: http://localhost:47779/tests/dromaeo/cssquery-dojo.html) 02:06:56 INFO - PID 4241 | RSS: Main: 149016576 02:06:56 INFO - PID 4241 | 02:06:56 INFO - PID 4241 | __start_tp_report 02:06:56 INFO - PID 4241 | _x_x_mozilla_page_load 02:06:56 INFO - PID 4241 | _x_x_mozilla_page_load_details 02:06:56 INFO - PID 4241 | |i|pagename|runs| 02:06:56 INFO - PID 4241 | |0;dojo.html;3988.800559972001;4032.435459035735;4032.5765794591575;4037.475128233329;4037.697172712047;6586.538942274043;6590.406863382294;6616.999999999994;6677.4991875609285;6742.662866856656;6586.27550969393;6632.436242919358;6706.295838936914;6714.49641276905;6742.831429214272;5842.269716285465;5921.319048309457;5937.67342796146;5949.524038076965;5967.194428752106;5866.911996320058;5872.853178670546;5894.646321220719;5954.9404505955035;5976.163337132805;5867.55993300502;5915.615484993483;5925.377835327293;5932.199153114339;5949.226600541945;5918.319393269786;5977.701114944235;6030.969845150768;6037.909431358533;6049.092636104576;5819.476247137735;5868.2664666916635;5909.940900591025;5976.5218782497295;6016.42843929826;6472.288048314682;6541.247756507967;6548.574342667712;6585.242697089848;6659.93340066598;7168.569885806868;7244.565326080452;7277.690015797154;7289.599072051035;7310.049693539806;7224.277572242786;7226.494145409823;7236.312550307765;7272.8545429091655;7314.08573928259;6625.436837868787;6644.103046088764;6717.496187785838;6750.8312292192595;6764.594124352506;7288.733790696698;7319.34125928669;7400.407967362598;7421.257874212643;7430.331270185709;7033.402160816388;7062.6821793019435;7125.144982602121;7126.180489243699;7144.607046612487;7141;7207.5675459472595;7210.927890721131;7214.711411543584;7284.235155308616;7115.146182458138;7125.394341481032;7206.099237595301;7208.387287080657;7211.963940180371;7100.857982840314;7110.32451917067;7132.821679458055;7204.855902881913;7208.459365547605;5329.360476742816;5354.973225133927;5392.164214546673;5408.269883565668;5420.4850539198715;4931.704097754075;4975.527324904128;5006.824761133343;5008.874778130503;5035.194368901031;6695.363940425652;6712.563683360566;6789.626570538668;6793.184817821893;6798.456123510107;7037.2962703730245;7141;7232.602206878672;7233.493655444174;7309.671064802096;6769.763058292936;6798.830029249309;6828.897566536506;6836.145481814773;6847.109875716125;6160.44555989963;6171.290301615371;6234.844128896814;6257.937420625826;6261.123442718023;7346.045014148127;7435.85128297431;7468.253174682488;7483.70065197386;7525.6989720410575;7151.320624540765;7156.248593897566;7162.964185179041;7165.996760453437;7169.4981351304905;7458.776236712907;7525;7558.470907036674;7575.204603516771;7584.165741768291;7040.683169257498;7083.043789088407;7096.503244773023;7180.497365184387;7228.674709637974;7126.394256488256;7236.529625574321;7257.709691612276;7339.59632220233;7341.889871652036;6975.476839236976;6981.162260528769;7046.295370462913;7054.153501579844;7074.469414793808;6986.056882320821;6993.0908981832035;6998.195207551197;7006.404455621329;7011.1586609607175;6829.6585170742255;6851.48613853953;6852.246252912076;6940.340667636567;6958.721651133898;6907.171139463096;6966.895496567454;7043.647817609201;7052.400545953651;7152.928470715435;6857.7256909723055;6857.862842743018;6942.2363540011565;6950.860982780215;6958.7216511341 02:06:56 INFO - PID 4241 | |1;ext.html;970;975.7072878136557;1001.3791449301434;1030.021479594385;1030.5980667539657;44153.55846441535;44980.32529512056;45770.54229457705;45777;45986.31020534695;46198.30702539464;46259;46581.53418465814;46652.533474665244;46661;8757.868631970525;8814.911850881505;8896.466212027266;8912.287017038621;8923.687670931518;8813.603387847563;8911.68809091682;8915.42049766763;8938.553072346356;8951.239144672678;8911.643534258621;8921.732348029536;8954.955225223897;8990.145936136056;8995.775105622346;8880.555972201397;8938.776530586754;8950.06024367445;8979.236764874928;8997.505137217484;8748.781280467976;8811.339149563808;8814.471131732053;8828.29373650113;8852.645894164225;41456.170876582604;41739.37390939138;41876.58123418788;41912.58087419148;42137.36793948093;3780.584135745066;3817.9809100954594;3818.0836599215986;3818.6372294631965;3823.2162406706557;33882.1529461763;33925.49111763325;34000.6599934;34040.65959340424;34268.31463370719;5554.333479982388;5660.518855897254;5704.971475142598;5748.223989761413;5825.737841797087;209846;211364;211415.99999999846;212321;212991;50711;50950.49049509457;50990.235146472834;51107.744461277456;53470.19794703083;56629.43370566324;56743.14885276724;56744.14883776747;56792.456603471626;56909.14636280459;15618.21908904573;15626;15652.530424087296;15662.373505059897;15768.290426930816;12385.93807030959;12416.81374779379;12495.187812792139;12498.562550310695;12509.124361294622;14940.701185976219;15022.774658380133;15060.171690556905;15148.16685082309;15257.389704411698;5669.801556945487;5693.345265294462;5811.535077193815;5826.1552074948895;5894.793682221188;1095.0801326885455;1103.8399432082304;1114.3091283404342;1114.375949468284;1121.7476067884825;26387.076452324076;26540.203793886216;26546.203613891616;26700.59949100765;26709.19872403792;1213.5934461955167;1221.517500587281;1226.0804396702474;1227.380173012623;1230.034422977976;13725.725485490235;13897.861021389657;13983.720325593431;14071.648208794863;14118.50585229512;292647;294935;299127;305966;309107;63627.68186159132;64364.67817660882;64562.677186613764;64747;64827;1517.0442621148607;1532.2185685300576;1537.1161582090342;1544.274191130167;1556.4163438710484;31480.527792082677;32011.679883201803;32190.35619287648;32499.837500812344;32735.83632081824;42840;43127.568724312354;43334.56665433432;43346.13307733765;43475.34786978135;274295;274325;275631;276659;278463;37980.43029354507;39145.21709565736;39630.60369396384;39681.40477892892;39711.80144099261;49270.26094608512;49379.50620493749;49612;49715.25427118524;49879.750601246764;36514.26971460609;36784.44823327599;37017.62982370142;37039.629603703615;37070.8146459266;36477.81761091178;36804.26391472209;36816;37237.62762372341;37395.06512337214;41419.37870931878;42459.1508169841;42775.3583696251;42854.35718464163;43405;35712;35718.64281357153;35817.641823582475;35867.28265434729;36510.174491274796;26455.33861653474;26571.202863914114;26830.865845670647;27264;27434.314142146606 02:06:56 INFO - PID 4241 | |2;jquery.html;643.4395122787258;645.2436605055882;655.3053763011211;656.2437761402109;658.7826017414254;24337.63493547596;24841.25476235711;25238.49523009541;25262.115825946097;25274.87362563189;26580.468390632224;26808.73191268087;26817.19548413546;26898.327541811464;26932.730672693266;6303.590266632654;6559.77040803572;6672.199336079677;6721.529492935497;6726.899096513556;6695.631740254284;6787.524873258873;6788.966055169717;6789.049533065375;6789.15135608049;6585.078089067534;6652.534322597396;6721.798346049626;6853.965730171342;6875.931240687604;6770.5599136056;6783.1860176778855;6814;6826.522143449985;6839.65801709915;6351.682415879188;6363.586366886184;6374.87250254997;6376.171097757308;6377.649229292387;31077;31697.207569810707;32032;32088.679113209037;32121.6787832121;2261.683364328995;2264.1735766445295;2267.1951457232776;2268.092762894839;2325.7790509901533;20440.080196391198;20970.685439718418;21139.577208455743;21215.36353909385;21247;2526.7978561715017;2543.6438898554215;2621.1743300860167;2628.1327162036673;2634.0912385227257;149634.25182874125;156419.2179039109;161632;168158.99999999878;168253;16682.499525014267;16779.496615101565;16852;17291.394801181897;17382;27258.318542036606;27262.727372726415;27318.180454586392;27359.316017099733;27460;10349.327293725884;10386.221033422524;10736.516856741466;10831.512581933832;10844.240903136862;9504.619815207452;9583.520823958774;9662.613495460244;9708.611655533841;9708.660196893075;10037.297389182688;10053.899461005296;10092.293539452168;10170;10439.895601043892;2947.924980047859;2963.955540666892;2973.152651494314;3068.5704001439817;3092.567040614316;1048.5648455890873;1054.5096530113533;1061.3737894642045;1069.6523629820183;1069.8823129455754;21551;21744.673829892563;21885.562288754136;21975.450613734465;22238.555228895333;1105.38098664748;1120.098320851706;1133.0991861470152;1141.1099342512853;1149.7413082056637;11813.586524471602;11966.521339146511;11996.100292478099;12087.456064477119;12221.877781222074;622325;625332;634423;634960;645356;129411;131877.3406132963;134153;134997;137678.31160844333;1229.6434034130182;1272.8472583290065;1287.8454585449806;1331.9067665263533;1350.2843492948753;22891.198808041638;23171.76828231696;23272.3018309451;23385;23431;66874.66562667156;67886.321136788;69168.6541567289;69752.3024769766;70809.64595176991;89573;90142.54928725315;90569;90612;91462;16662;16767.1616419181;16802.66394672124;16824.074675892454;16871.7469237964;24778;24855.87572062128;24896.50206995886;24926.127585534417;24997.625035624846;19777.901110494357;20166.596668066264;20168;20186.39440816778;20690.379288621367;18003;18189.272429102686;18189.363372281907;18258.908705456386;19138.138783754486;20305.28931487391;20502.38492845217;20507.872067036456;20574.279900203423;20631.793682062988;16177.27202275924;16243.431479898147;16365.34538618442;16375.344986200418;16394.672106558042;18084.90957545204;19620.509487262934;19996.400107996782;20062.699059514413;20151.294704685264 02:06:56 INFO - PID 4241 | |3;mootools.html;1443.134119528283;1531.2420351925798;1532.747096729039;1535.5086372360843;1549.7752825840257;17945.192466339013;18472.261109555617;18506.722399164024;18516.0741962902;18517;17916.28334866604;17990;18116.547086322847;18144.274229030823;18159;2887.9747689570163;3042.391521695659;3045.5888455058507;3046.4211799757977;3047.2686555226696;2942.161483977067;2986.059391291747;2997.6702562718083;2997.7451916587115;2999.8350090745002;2830.830150190985;3038;3041.574179614856;3042.6957304269617;3045.5279431688014;2956.393939242461;3015.050259168355;3022.591950086732;3027.0918724382595;3032.5906002689685;2943.5731818886356;2948.2187220386613;2962.8074175178544;2967.540031295131;2969.495185818416;16958.745618815727;17164.570885727833;17184.57038574033;17232.741508877378;17326.826731732774;8805.735827925173;9071.047540008336;9113.225375843062;9134.817303653956;9135.223506001998;5817.88364232713;6079.6048256863605;6183.1961844960315;6186.969065154691;6195.907061394083;2147.76374598794;2208.829437993033;2210.3810932938804;2252.7296724393013;2255.661650752384;32173.51739723906;32206.677933220602;32510.674893251;32594.83702581472;32645.51031734526;7213.963930180315;7255.310745479171;7331.633418329062;7453.440991925628;7514.962425187949;20484.487887802923;20611.4847128823;20644.896775516027;20654.07056682453;20696.48258793542;8184.427090103754;8313.958430207811;8328.208820162075;8328.458650187718;8339.45793523419;7519.511231770027;7544.660490277951;7589.582572958429;8037.799055023671;8280.461769985051;5894.2926848778425;5952.7023648817385;6043.395660434009;6061.333253342129;6293.496520278367;1584.4929622520913;1606.1407147176205;1627.4792066538594;1669.5891971284245;1723.1384307846076;980.4019548075668;988.4069558264983;1017.1100287248657;1018.0938964321759;1034.5034383495963;9879.901200987899;9885.654002109892;9895.059969302905;10001.199904007663;10117.848232276374;1056.4733959428552;1098.6594155811724;1112.8553288072499;1119.9496022679;1131.1911982932243;5643;5753.194552762617;5876.382979787061;5960.582759206901;5999;25616.48767024649;25885;26751.197464076107;26786.866065669547;27012.189634311002;25342.493150136896;26539.601905971427;26814.329641758723;26839.463210735677;27062.458750825266;13051.934740326238;13126.868731312565;13266.933665331611;13291.268980206181;13374.465021399035;9437.339386242897;9537.189338906272;9582.233421326138;9676.612935482783;9747.561359738687;22262.22082227114;22436.77563224347;22761.31716048521;22928.656070159293;22968.770312296663;23343.533129336978;23352.299431017098;23478.41303967346;23714.170004049774;24059.157929472385;12899.484020639069;12900.870991290343;13002.284874331624;13015.219086854819;13103.541376051793;15793;15990.440334588233;15997.840021599635;16001;16058.277377518274;13055.869441305465;13068.738625227252;13153.671158221121;13280.468781248643;13366.799498007733;12366.567170149001;12627.431765570387;12680.556180533637;12923.28921909304;12924.353782311035;11615.477303521193;11660.416979151178;11708.121890858049;11764;11783.293002419883;8064.596770161351;8178.059523154913;8290.709825156091;8298.294644955246;8326.50040997542;8429.831403372022;8492.575371231538;8494.74515764528;8586.098459661895;8624.870626940727 02:06:56 INFO - PID 4241 | |4;prototype.html;564.2664536103066;570.6176861502793;576.6396002498439;599.6522017230005;605.6033298189687;6271.843203919904;6376.872462550747;6401.871962560746;6404.167458230435;6473.223213214421;6317.74729010839;6366.670663948513;6406.967965160179;6421.261554921185;6453.967730161355;5249.658772179815;5280.841574752763;5299.947000529994;5314.219736388314;5328.227407025979;5043.39479262489;5101.693898366091;5129.974005198975;5170.3020092287625;5188.195829646411;5118.001989612008;5121.692698438087;5123.846284611468;5127.384713834345;5161.27742116104;5069.138246498104;5084.847454576368;5121.155009423441;5143.717095559743;5174.120399532069;4683.812647494096;4730.952690473086;4738.147133515966;4746.311784791186;4746.311784791221;6432.581882177644;6447.258565265008;6472.320406357312;6486.448651864597;6505.869882602369;6125.264968203844;6132.386761323876;6179.258488981306;6180.87638247237;6195.81412557624;6896.344847239504;6963.825904352381;6979.860402791966;6999.515172113928;7027.383701748627;5114.514121158484;5317.9468205317835;5332.813351532678;5345.812896548602;5346.599005074596;6968.721251149948;7035.788926332219;7209.603471809049;7243.384312333511;7301.379382752472;5461.208124821958;5468.562514998791;5483.150111732688;5484.424135465719;5501.174823776466;5535.169724541351;5550.666959982414;5558.943800677858;5564.165375193672;5566.35986861508;6118.277366571921;6134.815955521252;6148.78479253224;6157.630542167484;6163.476104531075;6939.097917270823;6998.510104292651;7038.788836334918;7041.802893508116;7050.823729406703;1874.8312651861124;1883.180816344867;1902.1250224896703;1904.2192700992803;1909.0931807391655;1287.1311864491618;1343.2142196814777;1354.7561438940888;1366.4397596985189;1373.9725205496034;6551.4103730664465;6558.8360290993105;6595.769148079794;6633.568818026813;6661.666916654245;7050.506464547535;7087.89368159478;7127;7145.571265724073;7155.356017958408;6575.967120164464;6611.941864473682;6619.716197911713;6628.701708423133;6640.169978752656;3706.777593344408;3712.480252764615;3733.8879833605033;3744.925101497955;3748.5876553579083;7137.321954414322;7170.354668079898;7370.77887663371;7380.594067326241;7394.223606521237;7147.82130446743;7205.747798827121;7272.63636818157;7298.781036568911;7330.486865919441;7259.310365515267;7261.6006119663925;7280.235575264627;7355.889661655079;7423.257674232534;6990.720371185095;7047.154341479055;7121.608311542915;7143.035690181759;7145.85708285821;6902.896456553055;7012.824679383056;7031.015657807809;7072.151341839012;7081.362677359062;7367.189609142883;7390.593517356597;7405.333519983012;7420.962895185489;7421.51760135611;5441.231599730025;5463.808766693147;5477.3427188737605;5493.2034854946605;5496.983058134258;6804;6890.552114112566;6980.581165130108;7009.773289674388;7022.824429389306;6657.700403481952;6829.214640316427;6835.487338449537;6843.281455447305;6890.207626122859;6693.933060669331;6750.8649827004165;6812.182538095461;6828.317168283132;6885.2770459101075;6591.703373348115;6680.76617318411;6714.232894644857;6741.730330786713;6784.4219196704935;6832.93167068323;6885;6898.827529311808;6904.378605925491;6997.580145191305;6697.296783837627;6750.8649827004165;6784.5929244243525;6844.897326540006;6851.45188384938 02:06:56 INFO - PID 4241 | |5;yui.html;869.3740506835077;885.3846576629242;893.5085702863423;902.4855832175663;906.900240973493;19828.306009289678;20694.586108277843;20718.171273149055;20854;20869.37391878246;19561.41315760526;20102.798972010274;20103.095360708765;20114.899425502852;20124.798752012477;1053.5680371047872;1070.8072546941587;1071.871375434949;1074.0870260278778;1082.880883102858;1091.7871015152048;1093.8468614393992;1094.020851338052;1096.9780604387906;1099.76355083657;1098.6319582939725;1129.2829053550972;1132.3488993828541;1132.5243397772913;1133.1557989297985;1117.2458590451495;1119.9944000279986;1120.008792218884;1121.43928035982;1122.4892673833426;818.705266104202;820.9425340226187;822.3462347433805;824.0688022534557;825.9628316725762;19629.901850490798;19658.70511942322;19741.21035158592;19858.503537411536;20117.195312187494;21150.365489035354;21383.67924481134;21807.890960545254;21870;21881.781182188293;17753.911230443893;17941.551461213443;18007.909960450244;18013.549661258443;18055.729164062548;3461.2558299965626;3520.1903562180587;3535.381308271042;3535.911602209965;3547.396942519778;157164;157182;158839;162141;163317;13636.386362613706;13725.45098196081;13879.653008674864;13966.301684915714;14106.788398174036;31862;32394.676053239167;32415.351692966007;32546.511802322984;33760.831195843864;9901;9986.500674966368;9990;9990.950045249872;9993;5018.749062546858;5052.469490703496;5061.468545802712;5067.949320506821;5069.264956581275;6184.8763024739255;6266.843328916813;6332.1135041094285;6333.778317758856;6338.271098823694;1093.9507722152523;1125.5104029747085;1132.7904337697553;1142.9142814288796;1152.4871432212585;701.5790525684548;735.3198291580267;735.7535225699344;738.9963050184715;753.6382536382567;11445.198836081561;11898.46456909441;11972.820407693891;11989.700257493458;12052.457639406073;654.9214094308713;664.9468042556681;666.4768156996831;671.0672165689696;675.5575098310615;5585.748641311151;5692.260006199168;5693.231413759089;5695.515881150066;5800.53595712342;156751.21624391805;158248;158606;158896.205518974;161410;135592;135812;136155.31922340524;140144;140289;118688.40655796666;119177.40411297888;119406.8059319413;120624.3968780168;122759;10836.837447438453;10955.233133680884;10955.287906286067;10978.670639880816;11029;55605.72197138988;55732.72133639306;56604.71697641486;56729;57544;71617;72162.63918680373;72726.63636681782;72929.27070729437;75058.62470687611;13530.526431574848;13847.23840188759;13874.930625347213;13933.651658708613;13937.860621394062;16174;16440.83559164441;16564.171791410623;16655.083970381744;16731.24709388056;14207.502737404142;14364.138151710931;14472.782908256175;14493.057951233137;14518;14121.858781412055;14195.574132776033;14330.85669143337;14440.566782996528;14444.85555144435;15083;15448.691026179638;15485.84514154844;15493.535193944199;15535.844641553891;11971.880281197426;12143.14997950135;12295.815562766387;12335;12474;11856;11950.880491195325;12009.219400738924;12079.577214797791;12191.939040304742 02:06:56 INFO - PID 4241 | __end_tp_report 02:06:56 INFO - PID 4241 | __start_cc_report 02:06:56 INFO - PID 4241 | _x_x_mozilla_cycle_collect,264 02:06:56 INFO - PID 4241 | __end_cc_report 02:06:56 INFO - PID 4241 | __startTimestamp1507108016167__endTimestamp 02:06:56 INFO - PID 4241 | 02:06:56 INFO - PID 4241 | ------- Summary: start ------- 02:06:56 INFO - PID 4241 | Number of tests: 6 02:06:56 INFO - PID 4241 | 02:06:56 INFO - PID 4241 | [#0] dojo.html Cycles:165 Average:6652.93 Median:6942.24 stddev:772.01 (11.1%) stddev-sans-first:745.56 02:06:56 INFO - PID 4241 | Values: 3988.8 4032.4 4032.6 4037.5 4037.7 6586.5 6590.4 6617.0 6677.5 6742.7 6586.3 6632.4 6706.3 6714.5 6742.8 5842.3 5921.3 5937.7 5949.5 5967.2 5866.9 5872.9 5894.6 5954.9 5976.2 5867.6 5915.6 5925.4 5932.2 5949.2 5918.3 5977.7 6031.0 6037.9 6049.1 5819.5 5868.3 5909.9 5976.5 6016.4 6472.3 6541.2 6548.6 6585.2 6659.9 7168.6 7244.6 7277.7 7289.6 7310.0 7224.3 7226.5 7236.3 7272.9 7314.1 6625.4 6644.1 6717.5 6750.8 6764.6 7288.7 7319.3 7400.4 7421.3 7430.3 7033.4 7062.7 7125.1 7126.2 7144.6 7141.0 7207.6 7210.9 7214.7 7284.2 7115.1 7125.4 7206.1 7208.4 7212.0 7100.9 7110.3 7132.8 7204.9 7208.5 5329.4 5355.0 5392.2 5408.3 5420.5 4931.7 4975.5 5006.8 5008.9 5035.2 6695.4 6712.6 6789.6 6793.2 6798.5 7037.3 7141.0 7232.6 7233.5 7309.7 6769.8 6798.8 6828.9 6836.1 6847.1 6160.4 6171.3 6234.8 6257.9 6261.1 7346.0 7435.9 7468.3 7483.7 7525.7 7151.3 7156.2 7163.0 7166.0 7169.5 7458.8 7525.0 7558.5 7575.2 7584.2 7040.7 7083.0 7096.5 7180.5 7228.7 7126.4 7236.5 7257.7 7339.6 7341.9 6975.5 6981.2 7046.3 7054.2 7074.5 6986.1 6993.1 6998.2 7006.4 7011.2 6829.7 6851.5 6852.2 6940.3 6958.7 6907.2 6966.9 7043.6 7052.4 7152.9 6857.7 6857.9 6942.2 6950.9 6958.7 02:06:56 INFO - PID 4241 | 02:06:56 INFO - PID 4241 | [#1] ext.html Cycles:180 Average:44998.86 Median:3818.03 stddev:69081.62 (1809.4%) stddev-sans-first:69196.31 02:06:56 INFO - PID 4241 | Values: 970.0 975.7 1001.4 1030.0 1030.6 44153.6 44980.3 45770.5 45777.0 45986.3 46198.3 46259.0 46581.5 46652.5 46661.0 8757.9 8814.9 8896.5 8912.3 8923.7 8813.6 8911.7 8915.4 8938.6 8951.2 8911.6 8921.7 8955.0 8990.1 8995.8 8880.6 8938.8 8950.1 8979.2 8997.5 8748.8 8811.3 8814.5 8828.3 8852.6 41456.2 41739.4 41876.6 41912.6 42137.4 3780.6 3818.0 3818.1 3818.6 3823.2 33882.2 33925.5 34000.7 34040.7 34268.3 5554.3 5660.5 5705.0 5748.2 5825.7 209846.0 211364.0 211416.0 212321.0 212991.0 50711.0 50950.5 50990.2 51107.7 53470.2 56629.4 56743.1 56744.1 56792.5 56909.1 15618.2 15626.0 15652.5 15662.4 15768.3 12385.9 12416.8 12495.2 12498.6 12509.1 14940.7 15022.8 15060.2 15148.2 15257.4 5669.8 5693.3 5811.5 5826.2 5894.8 1095.1 1103.8 1114.3 1114.4 1121.7 26387.1 26540.2 26546.2 26700.6 26709.2 1213.6 1221.5 1226.1 1227.4 1230.0 13725.7 13897.9 13983.7 14071.6 14118.5 292647.0 294935.0 299127.0 305966.0 309107.0 63627.7 64364.7 64562.7 64747.0 64827.0 1517.0 1532.2 1537.1 1544.3 1556.4 31480.5 32011.7 32190.4 32499.8 32735.8 42840.0 43127.6 43334.6 43346.1 43475.3 274295.0 274325.0 275631.0 276659.0 278463.0 37980.4 39145.2 39630.6 39681.4 39711.8 49270.3 49379.5 49612.0 49715.3 49879.8 36514.3 36784.4 37017.6 37039.6 37070.8 36477.8 36804.3 36816.0 37237.6 37395.1 41419.4 42459.2 42775.4 42854.4 43405.0 35712.0 35718.6 35817.6 35867.3 36510.2 26455.3 26571.2 26830.9 27264.0 27434.3 02:06:56 INFO - PID 4241 | 02:06:56 INFO - PID 4241 | [#2] jquery.html Cycles:180 Average:41797.14 Median:12748.77 stddev:105991.38 (831.4%) stddev-sans-first:106243.68 02:06:56 INFO - PID 4241 | Values: 643.4 645.2 655.3 656.2 658.8 24337.6 24841.3 25238.5 25262.1 25274.9 26580.5 26808.7 26817.2 26898.3 26932.7 6303.6 6559.8 6672.2 6721.5 6726.9 6695.6 6787.5 6789.0 6789.0 6789.2 6585.1 6652.5 6721.8 6854.0 6875.9 6770.6 6783.2 6814.0 6826.5 6839.7 6351.7 6363.6 6374.9 6376.2 6377.6 31077.0 31697.2 32032.0 32088.7 32121.7 2261.7 2264.2 2267.2 2268.1 2325.8 20440.1 20970.7 21139.6 21215.4 21247.0 2526.8 2543.6 2621.2 2628.1 2634.1 149634.3 156419.2 161632.0 168159.0 168253.0 16682.5 16779.5 16852.0 17291.4 17382.0 27258.3 27262.7 27318.2 27359.3 27460.0 10349.3 10386.2 10736.5 10831.5 10844.2 9504.6 9583.5 9662.6 9708.6 9708.7 10037.3 10053.9 10092.3 10170.0 10439.9 2947.9 2964.0 2973.2 3068.6 3092.6 1048.6 1054.5 1061.4 1069.7 1069.9 21551.0 21744.7 21885.6 21975.5 22238.6 1105.4 1120.1 1133.1 1141.1 1149.7 11813.6 11966.5 11996.1 12087.5 12221.9 622325.0 625332.0 634423.0 634960.0 645356.0 129411.0 131877.3 134153.0 134997.0 137678.3 1229.6 1272.8 1287.8 1331.9 1350.3 22891.2 23171.8 23272.3 23385.0 23431.0 66874.7 67886.3 69168.7 69752.3 70809.6 89573.0 90142.5 90569.0 90612.0 91462.0 16662.0 16767.2 16802.7 16824.1 16871.7 24778.0 24855.9 24896.5 24926.1 24997.6 19777.9 20166.6 20168.0 20186.4 20690.4 18003.0 18189.3 18189.4 18258.9 19138.1 20305.3 20502.4 20507.9 20574.3 20631.8 16177.3 16243.4 16365.3 16375.3 16394.7 18084.9 19620.5 19996.4 20062.7 20151.3 02:06:56 INFO - PID 4241 | 02:06:56 INFO - PID 4241 | [#3] mootools.html Cycles:180 Average:10969.10 Median:26800.60 stddev:8204.62 (30.6%) stddev-sans-first:8196.42 02:06:56 INFO - PID 4241 | Values: 1443.1 1531.2 1532.7 1535.5 1549.8 17945.2 18472.3 18506.7 18516.1 18517.0 17916.3 17990.0 18116.5 18144.3 18159.0 2888.0 3042.4 3045.6 3046.4 3047.3 2942.2 2986.1 2997.7 2997.7 2999.8 2830.8 3038.0 3041.6 3042.7 3045.5 2956.4 3015.1 3022.6 3027.1 3032.6 2943.6 2948.2 2962.8 2967.5 2969.5 16958.7 17164.6 17184.6 17232.7 17326.8 8805.7 9071.0 9113.2 9134.8 9135.2 5817.9 6079.6 6183.2 6187.0 6195.9 2147.8 2208.8 2210.4 2252.7 2255.7 32173.5 32206.7 32510.7 32594.8 32645.5 7214.0 7255.3 7331.6 7453.4 7515.0 20484.5 20611.5 20644.9 20654.1 20696.5 8184.4 8314.0 8328.2 8328.5 8339.5 7519.5 7544.7 7589.6 8037.8 8280.5 5894.3 5952.7 6043.4 6061.3 6293.5 1584.5 1606.1 1627.5 1669.6 1723.1 980.4 988.4 1017.1 1018.1 1034.5 9879.9 9885.7 9895.1 10001.2 10117.8 1056.5 1098.7 1112.9 1119.9 1131.2 5643.0 5753.2 5876.4 5960.6 5999.0 25616.5 25885.0 26751.2 26786.9 27012.2 25342.5 26539.6 26814.3 26839.5 27062.5 13051.9 13126.9 13266.9 13291.3 13374.5 9437.3 9537.2 9582.2 9676.6 9747.6 22262.2 22436.8 22761.3 22928.7 22968.8 23343.5 23352.3 23478.4 23714.2 24059.2 12899.5 12900.9 13002.3 13015.2 13103.5 15793.0 15990.4 15997.8 16001.0 16058.3 13055.9 13068.7 13153.7 13280.5 13366.8 12366.6 12627.4 12680.6 12923.3 12924.4 11615.5 11660.4 11708.1 11764.0 11783.3 8064.6 8178.1 8290.7 8298.3 8326.5 8429.8 8492.6 8494.7 8586.1 8624.9 02:06:56 INFO - PID 4241 | 02:06:56 INFO - PID 4241 | [#4] prototype.html Cycles:180 Average:5891.20 Median:6555.12 stddev:1649.95 (25.2%) stddev-sans-first:1605.40 02:06:56 INFO - PID 4241 | Values: 564.3 570.6 576.6 599.7 605.6 6271.8 6376.9 6401.9 6404.2 6473.2 6317.7 6366.7 6407.0 6421.3 6454.0 5249.7 5280.8 5299.9 5314.2 5328.2 5043.4 5101.7 5130.0 5170.3 5188.2 5118.0 5121.7 5123.8 5127.4 5161.3 5069.1 5084.8 5121.2 5143.7 5174.1 4683.8 4731.0 4738.1 4746.3 4746.3 6432.6 6447.3 6472.3 6486.4 6505.9 6125.3 6132.4 6179.3 6180.9 6195.8 6896.3 6963.8 6979.9 6999.5 7027.4 5114.5 5317.9 5332.8 5345.8 5346.6 6968.7 7035.8 7209.6 7243.4 7301.4 5461.2 5468.6 5483.2 5484.4 5501.2 5535.2 5550.7 5558.9 5564.2 5566.4 6118.3 6134.8 6148.8 6157.6 6163.5 6939.1 6998.5 7038.8 7041.8 7050.8 1874.8 1883.2 1902.1 1904.2 1909.1 1287.1 1343.2 1354.8 1366.4 1374.0 6551.4 6558.8 6595.8 6633.6 6661.7 7050.5 7087.9 7127.0 7145.6 7155.4 6576.0 6611.9 6619.7 6628.7 6640.2 3706.8 3712.5 3733.9 3744.9 3748.6 7137.3 7170.4 7370.8 7380.6 7394.2 7147.8 7205.7 7272.6 7298.8 7330.5 7259.3 7261.6 7280.2 7355.9 7423.3 6990.7 7047.2 7121.6 7143.0 7145.9 6902.9 7012.8 7031.0 7072.2 7081.4 7367.2 7390.6 7405.3 7421.0 7421.5 5441.2 5463.8 5477.3 5493.2 5497.0 6804.0 6890.6 6980.6 7009.8 7022.8 6657.7 6829.2 6835.5 6843.3 6890.2 6693.9 6750.9 6812.2 6828.3 6885.3 6591.7 6680.8 6714.2 6741.7 6784.4 6832.9 6885.0 6898.8 6904.4 6997.6 6697.3 6750.9 6784.6 6844.9 6851.5 02:06:56 INFO - PID 4241 | 02:06:56 INFO - PID 4241 | [#5] yui.html Cycles:180 Average:28131.80 Median:89878.92 stddev:43986.22 (48.9%) stddev-sans-first:44061.99 02:06:56 INFO - PID 4241 | Values: 869.4 885.4 893.5 902.5 906.9 19828.3 20694.6 20718.2 20854.0 20869.4 19561.4 20102.8 20103.1 20114.9 20124.8 1053.6 1070.8 1071.9 1074.1 1082.9 1091.8 1093.8 1094.0 1097.0 1099.8 1098.6 1129.3 1132.3 1132.5 1133.2 1117.2 1120.0 1120.0 1121.4 1122.5 818.7 820.9 822.3 824.1 826.0 19629.9 19658.7 19741.2 19858.5 20117.2 21150.4 21383.7 21807.9 21870.0 21881.8 17753.9 17941.6 18007.9 18013.5 18055.7 3461.3 3520.2 3535.4 3535.9 3547.4 157164.0 157182.0 158839.0 162141.0 163317.0 13636.4 13725.5 13879.7 13966.3 14106.8 31862.0 32394.7 32415.4 32546.5 33760.8 9901.0 9986.5 9990.0 9991.0 9993.0 5018.7 5052.5 5061.5 5067.9 5069.3 6184.9 6266.8 6332.1 6333.8 6338.3 1094.0 1125.5 1132.8 1142.9 1152.5 701.6 735.3 735.8 739.0 753.6 11445.2 11898.5 11972.8 11989.7 12052.5 654.9 664.9 666.5 671.1 675.6 5585.7 5692.3 5693.2 5695.5 5800.5 156751.2 158248.0 158606.0 158896.2 161410.0 135592.0 135812.0 136155.3 140144.0 140289.0 118688.4 119177.4 119406.8 120624.4 122759.0 10836.8 10955.2 10955.3 10978.7 11029.0 55605.7 55732.7 56604.7 56729.0 57544.0 71617.0 72162.6 72726.6 72929.3 75058.6 13530.5 13847.2 13874.9 13933.7 13937.9 16174.0 16440.8 16564.2 16655.1 16731.2 14207.5 14364.1 14472.8 14493.1 14518.0 14121.9 14195.6 14330.9 14440.6 14444.9 15083.0 15448.7 15485.8 15493.5 15535.8 11971.9 12143.1 12295.8 12335.0 12474.0 11856.0 11950.9 12009.2 12079.6 12191.9 02:06:56 INFO - PID 4241 | -------- Summary: end -------- 02:06:56 INFO - PID 4241 | 02:06:56 INFO - TEST-INFO | 4241: exit 0 02:06:56 INFO - TEST-OK | dromaeo_css | took 1107881ms 02:06:56 INFO - TEST-START | kraken 02:06:56 INFO - Initialising browser for kraken test... 02:06:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47779/getInfo.html -profile /tmp/tmp8a3ml_/profile 02:06:56 INFO - TEST-INFO | started process 4622 (/builds/slave/test/build/application/firefox/firefox http://localhost:47779/getInfo.html) 02:07:01 INFO - TEST-INFO | 4622: exit 0 02:07:01 INFO - Browser initialized. 02:07:01 INFO - Running cycle 1/1 for kraken test... 02:07:01 INFO - Using env: {'DISPLAY': ':0', 02:07:01 INFO - 'HOME': '/home/cltbld', 02:07:01 INFO - 'JSGC_DISABLE_POISONING': '1', 02:07:01 INFO - 'LANG': 'en_US.UTF-8', 02:07:01 INFO - 'LANGUAGE': 'en_US:en', 02:07:01 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:07:01 INFO - 'LOGNAME': 'cltbld', 02:07:01 INFO - 'MAIL': '/var/mail/cltbld', 02:07:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:07:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:07:01 INFO - 'MOZ_CRASHREPORTER': '1', 02:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:01 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:07:01 INFO - 'MOZ_NO_REMOTE': '1', 02:07:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:01 INFO - 'NO_EM_RESTART': '1', 02:07:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:01 INFO - 'PWD': '/builds/slave/test', 02:07:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:07:01 INFO - 'RUST_BACKTRACE': 'full', 02:07:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:07:01 INFO - 'SHELL': '/bin/bash', 02:07:01 INFO - 'SHLVL': '1', 02:07:01 INFO - 'TERM': 'linux', 02:07:01 INFO - 'TMOUT': '86400', 02:07:01 INFO - 'USER': 'cltbld', 02:07:01 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1507086409.818686-525191384', 02:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:01 INFO - '_': '/tools/buildbot/bin/python'} 02:07:01 INFO - TEST-INFO | started process 4852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8a3ml_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:02 INFO - PID 4852 | 02:07:02 INFO - PID 4852 | (/builds/slave/test/build/application/firefox/firefox:4900): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:07:02 INFO - PID 4852 | 02:07:12 INFO - PID 4852 | RSS: Main: 143380480 02:07:12 INFO - PID 4852 | 02:07:15 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47779/tests/kraken/driver.html?testName=audio-beat-detection) 02:07:15 INFO - PID 4852 | RSS: Main: 149708800 02:07:15 INFO - PID 4852 | 02:07:18 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47779/tests/kraken/driver.html?testName=audio-dft) 02:07:18 INFO - PID 4852 | RSS: Main: 150011904 02:07:18 INFO - PID 4852 | 02:07:21 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47779/tests/kraken/driver.html?testName=audio-fft) 02:07:22 INFO - PID 4852 | RSS: Main: 151285760 02:07:22 INFO - PID 4852 | 02:07:24 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47779/tests/kraken/driver.html?testName=audio-oscillator) 02:07:25 INFO - PID 4852 | RSS: Main: 151289856 02:07:25 INFO - PID 4852 | 02:07:27 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47779/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:07:27 INFO - PID 4852 | RSS: Main: 151703552 02:07:27 INFO - PID 4852 | 02:07:30 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47779/tests/kraken/driver.html?testName=imaging-darkroom) 02:07:31 INFO - PID 4852 | RSS: Main: 151220224 02:07:31 INFO - PID 4852 | 02:07:34 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47779/tests/kraken/driver.html?testName=imaging-desaturate) 02:07:35 INFO - PID 4852 | RSS: Main: 153886720 02:07:35 INFO - PID 4852 | 02:07:38 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47779/tests/kraken/driver.html?testName=json-parse-financial) 02:07:38 INFO - PID 4852 | RSS: Main: 154353664 02:07:38 INFO - PID 4852 | 02:07:40 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47779/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:07:40 INFO - PID 4852 | RSS: Main: 154333184 02:07:40 INFO - PID 4852 | 02:07:42 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47779/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:07:43 INFO - PID 4852 | RSS: Main: 154091520 02:07:43 INFO - PID 4852 | 02:07:45 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47779/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:07:45 INFO - PID 4852 | RSS: Main: 150876160 02:07:45 INFO - PID 4852 | 02:07:48 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:07:48 INFO - PID 4852 | RSS: Main: 150777856 02:07:48 INFO - PID 4852 | 02:07:51 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:07:52 INFO - PID 4852 | RSS: Main: 151425024 02:07:52 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | Cycle 1(1): loaded http://localhost:47779/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47779/tests/kraken/driver.html?testName=ai-astar) 02:07:53 INFO - PID 4852 | RSS: Main: 152813568 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | __start_tp_report 02:07:53 INFO - PID 4852 | _x_x_mozilla_page_load 02:07:53 INFO - PID 4852 | _x_x_mozilla_page_load_details 02:07:53 INFO - PID 4852 | |i|pagename|runs| 02:07:53 INFO - PID 4852 | |0;ai-astar;106;105;106;105;105;116;105;105;106;107 02:07:53 INFO - PID 4852 | |1;audio-beat-detection;115;112;111;116;110;115;110;110;114;120 02:07:53 INFO - PID 4852 | |2;audio-dft;160;159;162;161;161;160;161;161;163;160 02:07:53 INFO - PID 4852 | |3;audio-fft;75;73;73;73;73;74;74;73;74;73 02:07:53 INFO - PID 4852 | |4;audio-oscillator;81;77;76;77;77;78;77;78;78;78 02:07:53 INFO - PID 4852 | |5;imaging-gaussian-blur;110;114;113;116;115;113;113;113;114;111 02:07:53 INFO - PID 4852 | |6;imaging-darkroom;148;148;148;151;150;149;148;149;148;149 02:07:53 INFO - PID 4852 | |7;imaging-desaturate;94;94;97;93;93;94;94;94;96;95 02:07:53 INFO - PID 4852 | |8;json-parse-financial;50;47;45;45;47;45;45;44;44;45 02:07:53 INFO - PID 4852 | |9;json-stringify-tinderbox;38;38;39;39;38;39;39;38;38;38 02:07:53 INFO - PID 4852 | |10;stanford-crypto-aes;72;71;73;71;72;74;71;72;71;70 02:07:53 INFO - PID 4852 | |11;stanford-crypto-ccm;109;103;109;108;105;101;106;106;106;109 02:07:53 INFO - PID 4852 | |12;stanford-crypto-pbkdf2;155;147;158;150;148;147;145;152;146;155 02:07:53 INFO - PID 4852 | |13;stanford-crypto-sha256-iterative;60;58;59;59;55;58;60;58;59;59 02:07:53 INFO - PID 4852 | __end_tp_report 02:07:53 INFO - PID 4852 | __start_cc_report 02:07:53 INFO - PID 4852 | _x_x_mozilla_cycle_collect,719 02:07:53 INFO - PID 4852 | __end_cc_report 02:07:53 INFO - PID 4852 | __startTimestamp1507108073921__endTimestamp 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | ------- Summary: start ------- 02:07:53 INFO - PID 4852 | Number of tests: 14 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#0] ai-astar Cycles:10 Average:106.60 Median:106.00 stddev:3.37 (3.2%) stddev-sans-first:3.57 02:07:53 INFO - PID 4852 | Values: 106.0 105.0 106.0 105.0 105.0 116.0 105.0 105.0 106.0 107.0 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#1] audio-beat-detection Cycles:10 Average:113.30 Median:114.50 stddev:3.30 (2.9%) stddev-sans-first:3.44 02:07:53 INFO - PID 4852 | Values: 115.0 112.0 111.0 116.0 110.0 115.0 110.0 110.0 114.0 120.0 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.17 02:07:53 INFO - PID 4852 | Values: 160.0 159.0 162.0 161.0 161.0 160.0 161.0 161.0 163.0 160.0 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#3] audio-fft Cycles:10 Average:73.50 Median:73.50 stddev:0.71 (1.0%) stddev-sans-first:0.50 02:07:53 INFO - PID 4852 | Values: 75.0 73.0 73.0 73.0 73.0 74.0 74.0 73.0 74.0 73.0 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#4] audio-oscillator Cycles:10 Average:77.70 Median:78.00 stddev:1.34 (1.7%) stddev-sans-first:0.71 02:07:53 INFO - PID 4852 | Values: 81.0 77.0 76.0 77.0 77.0 78.0 77.0 78.0 78.0 78.0 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.50 stddev:1.75 (1.5%) stddev-sans-first:1.42 02:07:53 INFO - PID 4852 | Values: 110.0 114.0 113.0 116.0 115.0 113.0 113.0 113.0 114.0 111.0 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 02:07:53 INFO - PID 4852 | Values: 148.0 148.0 148.0 151.0 150.0 149.0 148.0 149.0 148.0 149.0 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.26 (1.3%) stddev-sans-first:1.33 02:07:53 INFO - PID 4852 | Values: 94.0 94.0 97.0 93.0 93.0 94.0 94.0 94.0 96.0 95.0 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#8] json-parse-financial Cycles:10 Average:45.70 Median:45.00 stddev:1.83 (4.1%) stddev-sans-first:1.09 02:07:53 INFO - PID 4852 | Values: 50.0 47.0 45.0 45.0 47.0 45.0 45.0 44.0 44.0 45.0 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#9] json-stringify-tinderbox Cycles:10 Average:38.40 Median:38.50 stddev:0.52 (1.3%) stddev-sans-first:0.53 02:07:53 INFO - PID 4852 | Values: 38.0 38.0 39.0 39.0 38.0 39.0 39.0 38.0 38.0 38.0 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#10] stanford-crypto-aes Cycles:10 Average:71.70 Median:72.00 stddev:1.16 (1.6%) stddev-sans-first:1.22 02:07:53 INFO - PID 4852 | Values: 72.0 71.0 73.0 71.0 72.0 74.0 71.0 72.0 71.0 70.0 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#11] stanford-crypto-ccm Cycles:10 Average:106.20 Median:107.00 stddev:2.70 (2.5%) stddev-sans-first:2.67 02:07:53 INFO - PID 4852 | Values: 109.0 103.0 109.0 108.0 105.0 101.0 106.0 106.0 106.0 109.0 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.30 Median:151.00 stddev:4.47 (3.0%) stddev-sans-first:4.41 02:07:53 INFO - PID 4852 | Values: 155.0 147.0 158.0 150.0 148.0 147.0 145.0 152.0 146.0 155.0 02:07:53 INFO - PID 4852 | 02:07:53 INFO - PID 4852 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.50 Median:59.00 stddev:1.43 (2.4%) stddev-sans-first:1.41 02:07:53 INFO - PID 4852 | Values: 60.0 58.0 59.0 59.0 55.0 58.0 60.0 58.0 59.0 59.0 02:07:53 INFO - PID 4852 | -------- Summary: end -------- 02:07:53 INFO - PID 4852 | 02:07:54 INFO - PID 4852 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:07:54 INFO - TEST-INFO | 4852: exit 0 02:07:54 INFO - TEST-OK | kraken | took 57712ms 02:07:54 INFO - SUITE-END | took 1165s 02:07:54 INFO - Completed test suite (00:19:25) 02:07:54 INFO - javascript benchmark 02:07:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9349.918783602336, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3988.800559972001, 4032.435459035735, 4032.5765794591575, 4037.475128233329, 4037.697172712047, 6586.538942274043, 6590.406863382294, 6616.999999999994, 6677.4991875609285, 6742.662866856656, 6586.27550969393, 6632.436242919358, 6706.295838936914, 6714.49641276905, 6742.831429214272, 5842.269716285465, 5921.319048309457, 5937.67342796146, 5949.524038076965, 5967.194428752106, 5866.911996320058, 5872.853178670546, 5894.646321220719, 5954.9404505955035, 5976.163337132805, 5867.55993300502, 5915.615484993483, 5925.377835327293, 5932.199153114339, 5949.226600541945, 5918.319393269786, 5977.701114944235, 6030.969845150768, 6037.909431358533, 6049.092636104576, 5819.476247137735, 5868.2664666916635, 5909.940900591025, 5976.5218782497295, 6016.42843929826, 6472.288048314682, 6541.247756507967, 6548.574342667712, 6585.242697089848, 6659.93340066598, 7168.569885806868, 7244.565326080452, 7277.690015797154, 7289.599072051035, 7310.049693539806, 7224.277572242786, 7226.494145409823, 7236.312550307765, 7272.8545429091655, 7314.08573928259, 6625.436837868787, 6644.103046088764, 6717.496187785838, 6750.8312292192595, 6764.594124352506, 7288.733790696698, 7319.34125928669, 7400.407967362598, 7421.257874212643, 7430.331270185709, 7033.402160816388, 7062.6821793019435, 7125.144982602121, 7126.180489243699, 7144.607046612487, 7141.0, 7207.5675459472595, 7210.927890721131, 7214.711411543584, 7284.235155308616, 7115.146182458138, 7125.394341481032, 7206.099237595301, 7208.387287080657, 7211.963940180371, 7100.857982840314, 7110.32451917067, 7132.821679458055, 7204.855902881913, 7208.459365547605, 5329.360476742816, 5354.973225133927, 5392.164214546673, 5408.269883565668, 5420.4850539198715, 4931.704097754075, 4975.527324904128, 5006.824761133343, 5008.874778130503, 5035.194368901031, 6695.363940425652, 6712.563683360566, 6789.626570538668, 6793.184817821893, 6798.456123510107, 7037.2962703730245, 7141.0, 7232.602206878672, 7233.493655444174, 7309.671064802096, 6769.763058292936, 6798.830029249309, 6828.897566536506, 6836.145481814773, 6847.109875716125, 6160.44555989963, 6171.290301615371, 6234.844128896814, 6257.937420625826, 6261.123442718023, 7346.045014148127, 7435.85128297431, 7468.253174682488, 7483.70065197386, 7525.6989720410575, 7151.320624540765, 7156.248593897566, 7162.964185179041, 7165.996760453437, 7169.4981351304905, 7458.776236712907, 7525.0, 7558.470907036674, 7575.204603516771, 7584.165741768291, 7040.683169257498, 7083.043789088407, 7096.503244773023, 7180.497365184387, 7228.674709637974, 7126.394256488256, 7236.529625574321, 7257.709691612276, 7339.59632220233, 7341.889871652036, 6975.476839236976, 6981.162260528769, 7046.295370462913, 7054.153501579844, 7074.469414793808, 6986.056882320821, 6993.0908981832035, 6998.195207551197, 7006.404455621329, 7011.1586609607175, 6829.6585170742255, 6851.48613853953, 6852.246252912076, 6940.340667636567, 6958.721651133898, 6907.171139463096, 6966.895496567454, 7043.647817609201, 7052.400545953651, 7152.928470715435, 6857.7256909723055, 6857.862842743018, 6942.2363540011565, 6950.860982780215, 6958.7216511341], "value": 6601.262522582602, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [970.0, 975.7072878136557, 1001.3791449301434, 1030.021479594385, 1030.5980667539657, 44153.55846441535, 44980.32529512056, 45770.54229457705, 45777.0, 45986.31020534695, 46198.30702539464, 46259.0, 46581.53418465814, 46652.533474665244, 46661.0, 8757.868631970525, 8814.911850881505, 8896.466212027266, 8912.287017038621, 8923.687670931518, 8813.603387847563, 8911.68809091682, 8915.42049766763, 8938.553072346356, 8951.239144672678, 8911.643534258621, 8921.732348029536, 8954.955225223897, 8990.145936136056, 8995.775105622346, 8880.555972201397, 8938.776530586754, 8950.06024367445, 8979.236764874928, 8997.505137217484, 8748.781280467976, 8811.339149563808, 8814.471131732053, 8828.29373650113, 8852.645894164225, 41456.170876582604, 41739.37390939138, 41876.58123418788, 41912.58087419148, 42137.36793948093, 3780.584135745066, 3817.9809100954594, 3818.0836599215986, 3818.6372294631965, 3823.2162406706557, 33882.1529461763, 33925.49111763325, 34000.6599934, 34040.65959340424, 34268.31463370719, 5554.333479982388, 5660.518855897254, 5704.971475142598, 5748.223989761413, 5825.737841797087, 209846.0, 211364.0, 211415.99999999846, 212321.0, 212991.0, 50711.0, 50950.49049509457, 50990.235146472834, 51107.744461277456, 53470.19794703083, 56629.43370566324, 56743.14885276724, 56744.14883776747, 56792.456603471626, 56909.14636280459, 15618.21908904573, 15626.0, 15652.530424087296, 15662.373505059897, 15768.290426930816, 12385.93807030959, 12416.81374779379, 12495.187812792139, 12498.562550310695, 12509.124361294622, 14940.701185976219, 15022.774658380133, 15060.171690556905, 15148.16685082309, 15257.389704411698, 5669.801556945487, 5693.345265294462, 5811.535077193815, 5826.1552074948895, 5894.793682221188, 1095.0801326885455, 1103.8399432082304, 1114.3091283404342, 1114.375949468284, 1121.7476067884825, 26387.076452324076, 26540.203793886216, 26546.203613891616, 26700.59949100765, 26709.19872403792, 1213.5934461955167, 1221.517500587281, 1226.0804396702474, 1227.380173012623, 1230.034422977976, 13725.725485490235, 13897.861021389657, 13983.720325593431, 14071.648208794863, 14118.50585229512, 292647.0, 294935.0, 299127.0, 305966.0, 309107.0, 63627.68186159132, 64364.67817660882, 64562.677186613764, 64747.0, 64827.0, 1517.0442621148607, 1532.2185685300576, 1537.1161582090342, 1544.274191130167, 1556.4163438710484, 31480.527792082677, 32011.679883201803, 32190.35619287648, 32499.837500812344, 32735.83632081824, 42840.0, 43127.568724312354, 43334.56665433432, 43346.13307733765, 43475.34786978135, 274295.0, 274325.0, 275631.0, 276659.0, 278463.0, 37980.43029354507, 39145.21709565736, 39630.60369396384, 39681.40477892892, 39711.80144099261, 49270.26094608512, 49379.50620493749, 49612.0, 49715.25427118524, 49879.750601246764, 36514.26971460609, 36784.44823327599, 37017.62982370142, 37039.629603703615, 37070.8146459266, 36477.81761091178, 36804.26391472209, 36816.0, 37237.62762372341, 37395.06512337214, 41419.37870931878, 42459.1508169841, 42775.3583696251, 42854.35718464163, 43405.0, 35712.0, 35718.64281357153, 35817.641823582475, 35867.28265434729, 36510.174491274796, 26455.33861653474, 26571.202863914114, 26830.865845670647, 27264.0, 27434.314142146606], "value": 19425.58832435366, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.4395122787258, 645.2436605055882, 655.3053763011211, 656.2437761402109, 658.7826017414254, 24337.63493547596, 24841.25476235711, 25238.49523009541, 25262.115825946097, 25274.87362563189, 26580.468390632224, 26808.73191268087, 26817.19548413546, 26898.327541811464, 26932.730672693266, 6303.590266632654, 6559.77040803572, 6672.199336079677, 6721.529492935497, 6726.899096513556, 6695.631740254284, 6787.524873258873, 6788.966055169717, 6789.049533065375, 6789.15135608049, 6585.078089067534, 6652.534322597396, 6721.798346049626, 6853.965730171342, 6875.931240687604, 6770.5599136056, 6783.1860176778855, 6814.0, 6826.522143449985, 6839.65801709915, 6351.682415879188, 6363.586366886184, 6374.87250254997, 6376.171097757308, 6377.649229292387, 31077.0, 31697.207569810707, 32032.0, 32088.679113209037, 32121.6787832121, 2261.683364328995, 2264.1735766445295, 2267.1951457232776, 2268.092762894839, 2325.7790509901533, 20440.080196391198, 20970.685439718418, 21139.577208455743, 21215.36353909385, 21247.0, 2526.7978561715017, 2543.6438898554215, 2621.1743300860167, 2628.1327162036673, 2634.0912385227257, 149634.25182874125, 156419.2179039109, 161632.0, 168158.99999999878, 168253.0, 16682.499525014267, 16779.496615101565, 16852.0, 17291.394801181897, 17382.0, 27258.318542036606, 27262.727372726415, 27318.180454586392, 27359.316017099733, 27460.0, 10349.327293725884, 10386.221033422524, 10736.516856741466, 10831.512581933832, 10844.240903136862, 9504.619815207452, 9583.520823958774, 9662.613495460244, 9708.611655533841, 9708.660196893075, 10037.297389182688, 10053.899461005296, 10092.293539452168, 10170.0, 10439.895601043892, 2947.924980047859, 2963.955540666892, 2973.152651494314, 3068.5704001439817, 3092.567040614316, 1048.5648455890873, 1054.5096530113533, 1061.3737894642045, 1069.6523629820183, 1069.8823129455754, 21551.0, 21744.673829892563, 21885.562288754136, 21975.450613734465, 22238.555228895333, 1105.38098664748, 1120.098320851706, 1133.0991861470152, 1141.1099342512853, 1149.7413082056637, 11813.586524471602, 11966.521339146511, 11996.100292478099, 12087.456064477119, 12221.877781222074, 622325.0, 625332.0, 634423.0, 634960.0, 645356.0, 129411.0, 131877.3406132963, 134153.0, 134997.0, 137678.31160844333, 1229.6434034130182, 1272.8472583290065, 1287.8454585449806, 1331.9067665263533, 1350.2843492948753, 22891.198808041638, 23171.76828231696, 23272.3018309451, 23385.0, 23431.0, 66874.66562667156, 67886.321136788, 69168.6541567289, 69752.3024769766, 70809.64595176991, 89573.0, 90142.54928725315, 90569.0, 90612.0, 91462.0, 16662.0, 16767.1616419181, 16802.66394672124, 16824.074675892454, 16871.7469237964, 24778.0, 24855.87572062128, 24896.50206995886, 24926.127585534417, 24997.625035624846, 19777.901110494357, 20166.596668066264, 20168.0, 20186.39440816778, 20690.379288621367, 18003.0, 18189.272429102686, 18189.363372281907, 18258.908705456386, 19138.138783754486, 20305.28931487391, 20502.38492845217, 20507.872067036456, 20574.279900203423, 20631.793682062988, 16177.27202275924, 16243.431479898147, 16365.34538618442, 16375.344986200418, 16394.672106558042, 18084.90957545204, 19620.509487262934, 19996.400107996782, 20062.699059514413, 20151.294704685264], "value": 13272.841875315667, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.134119528283, 1531.2420351925798, 1532.747096729039, 1535.5086372360843, 1549.7752825840257, 17945.192466339013, 18472.261109555617, 18506.722399164024, 18516.0741962902, 18517.0, 17916.28334866604, 17990.0, 18116.547086322847, 18144.274229030823, 18159.0, 2887.9747689570163, 3042.391521695659, 3045.5888455058507, 3046.4211799757977, 3047.2686555226696, 2942.161483977067, 2986.059391291747, 2997.6702562718083, 2997.7451916587115, 2999.8350090745002, 2830.830150190985, 3038.0, 3041.574179614856, 3042.6957304269617, 3045.5279431688014, 2956.393939242461, 3015.050259168355, 3022.591950086732, 3027.0918724382595, 3032.5906002689685, 2943.5731818886356, 2948.2187220386613, 2962.8074175178544, 2967.540031295131, 2969.495185818416, 16958.745618815727, 17164.570885727833, 17184.57038574033, 17232.741508877378, 17326.826731732774, 8805.735827925173, 9071.047540008336, 9113.225375843062, 9134.817303653956, 9135.223506001998, 5817.88364232713, 6079.6048256863605, 6183.1961844960315, 6186.969065154691, 6195.907061394083, 2147.76374598794, 2208.829437993033, 2210.3810932938804, 2252.7296724393013, 2255.661650752384, 32173.51739723906, 32206.677933220602, 32510.674893251, 32594.83702581472, 32645.51031734526, 7213.963930180315, 7255.310745479171, 7331.633418329062, 7453.440991925628, 7514.962425187949, 20484.487887802923, 20611.4847128823, 20644.896775516027, 20654.07056682453, 20696.48258793542, 8184.427090103754, 8313.958430207811, 8328.208820162075, 8328.458650187718, 8339.45793523419, 7519.511231770027, 7544.660490277951, 7589.582572958429, 8037.799055023671, 8280.461769985051, 5894.2926848778425, 5952.7023648817385, 6043.395660434009, 6061.333253342129, 6293.496520278367, 1584.4929622520913, 1606.1407147176205, 1627.4792066538594, 1669.5891971284245, 1723.1384307846076, 980.4019548075668, 988.4069558264983, 1017.1100287248657, 1018.0938964321759, 1034.5034383495963, 9879.901200987899, 9885.654002109892, 9895.059969302905, 10001.199904007663, 10117.848232276374, 1056.4733959428552, 1098.6594155811724, 1112.8553288072499, 1119.9496022679, 1131.1911982932243, 5643.0, 5753.194552762617, 5876.382979787061, 5960.582759206901, 5999.0, 25616.48767024649, 25885.0, 26751.197464076107, 26786.866065669547, 27012.189634311002, 25342.493150136896, 26539.601905971427, 26814.329641758723, 26839.463210735677, 27062.458750825266, 13051.934740326238, 13126.868731312565, 13266.933665331611, 13291.268980206181, 13374.465021399035, 9437.339386242897, 9537.189338906272, 9582.233421326138, 9676.612935482783, 9747.561359738687, 22262.22082227114, 22436.77563224347, 22761.31716048521, 22928.656070159293, 22968.770312296663, 23343.533129336978, 23352.299431017098, 23478.41303967346, 23714.170004049774, 24059.157929472385, 12899.484020639069, 12900.870991290343, 13002.284874331624, 13015.219086854819, 13103.541376051793, 15793.0, 15990.440334588233, 15997.840021599635, 16001.0, 16058.277377518274, 13055.869441305465, 13068.738625227252, 13153.671158221121, 13280.468781248643, 13366.799498007733, 12366.567170149001, 12627.431765570387, 12680.556180533637, 12923.28921909304, 12924.353782311035, 11615.477303521193, 11660.416979151178, 11708.121890858049, 11764.0, 11783.293002419883, 8064.596770161351, 8178.059523154913, 8290.709825156091, 8298.294644955246, 8326.50040997542, 8429.831403372022, 8492.575371231538, 8494.74515764528, 8586.098459661895, 8624.870626940727], "value": 7668.625224505393, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.2664536103066, 570.6176861502793, 576.6396002498439, 599.6522017230005, 605.6033298189687, 6271.843203919904, 6376.872462550747, 6401.871962560746, 6404.167458230435, 6473.223213214421, 6317.74729010839, 6366.670663948513, 6406.967965160179, 6421.261554921185, 6453.967730161355, 5249.658772179815, 5280.841574752763, 5299.947000529994, 5314.219736388314, 5328.227407025979, 5043.39479262489, 5101.693898366091, 5129.974005198975, 5170.3020092287625, 5188.195829646411, 5118.001989612008, 5121.692698438087, 5123.846284611468, 5127.384713834345, 5161.27742116104, 5069.138246498104, 5084.847454576368, 5121.155009423441, 5143.717095559743, 5174.120399532069, 4683.812647494096, 4730.952690473086, 4738.147133515966, 4746.311784791186, 4746.311784791221, 6432.581882177644, 6447.258565265008, 6472.320406357312, 6486.448651864597, 6505.869882602369, 6125.264968203844, 6132.386761323876, 6179.258488981306, 6180.87638247237, 6195.81412557624, 6896.344847239504, 6963.825904352381, 6979.860402791966, 6999.515172113928, 7027.383701748627, 5114.514121158484, 5317.9468205317835, 5332.813351532678, 5345.812896548602, 5346.599005074596, 6968.721251149948, 7035.788926332219, 7209.603471809049, 7243.384312333511, 7301.379382752472, 5461.208124821958, 5468.562514998791, 5483.150111732688, 5484.424135465719, 5501.174823776466, 5535.169724541351, 5550.666959982414, 5558.943800677858, 5564.165375193672, 5566.35986861508, 6118.277366571921, 6134.815955521252, 6148.78479253224, 6157.630542167484, 6163.476104531075, 6939.097917270823, 6998.510104292651, 7038.788836334918, 7041.802893508116, 7050.823729406703, 1874.8312651861124, 1883.180816344867, 1902.1250224896703, 1904.2192700992803, 1909.0931807391655, 1287.1311864491618, 1343.2142196814777, 1354.7561438940888, 1366.4397596985189, 1373.9725205496034, 6551.4103730664465, 6558.8360290993105, 6595.769148079794, 6633.568818026813, 6661.666916654245, 7050.506464547535, 7087.89368159478, 7127.0, 7145.571265724073, 7155.356017958408, 6575.967120164464, 6611.941864473682, 6619.716197911713, 6628.701708423133, 6640.169978752656, 3706.777593344408, 3712.480252764615, 3733.8879833605033, 3744.925101497955, 3748.5876553579083, 7137.321954414322, 7170.354668079898, 7370.77887663371, 7380.594067326241, 7394.223606521237, 7147.82130446743, 7205.747798827121, 7272.63636818157, 7298.781036568911, 7330.486865919441, 7259.310365515267, 7261.6006119663925, 7280.235575264627, 7355.889661655079, 7423.257674232534, 6990.720371185095, 7047.154341479055, 7121.608311542915, 7143.035690181759, 7145.85708285821, 6902.896456553055, 7012.824679383056, 7031.015657807809, 7072.151341839012, 7081.362677359062, 7367.189609142883, 7390.593517356597, 7405.333519983012, 7420.962895185489, 7421.51760135611, 5441.231599730025, 5463.808766693147, 5477.3427188737605, 5493.2034854946605, 5496.983058134258, 6804.0, 6890.552114112566, 6980.581165130108, 7009.773289674388, 7022.824429389306, 6657.700403481952, 6829.214640316427, 6835.487338449537, 6843.281455447305, 6890.207626122859, 6693.933060669331, 6750.8649827004165, 6812.182538095461, 6828.317168283132, 6885.2770459101075, 6591.703373348115, 6680.76617318411, 6714.232894644857, 6741.730330786713, 6784.4219196704935, 6832.93167068323, 6885.0, 6898.827529311808, 6904.378605925491, 6997.580145191305, 6697.296783837627, 6750.8649827004165, 6784.5929244243525, 6844.897326540006, 6851.45188384938], "value": 5415.569320827176, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.3740506835077, 885.3846576629242, 893.5085702863423, 902.4855832175663, 906.900240973493, 19828.306009289678, 20694.586108277843, 20718.171273149055, 20854.0, 20869.37391878246, 19561.41315760526, 20102.798972010274, 20103.095360708765, 20114.899425502852, 20124.798752012477, 1053.5680371047872, 1070.8072546941587, 1071.871375434949, 1074.0870260278778, 1082.880883102858, 1091.7871015152048, 1093.8468614393992, 1094.020851338052, 1096.9780604387906, 1099.76355083657, 1098.6319582939725, 1129.2829053550972, 1132.3488993828541, 1132.5243397772913, 1133.1557989297985, 1117.2458590451495, 1119.9944000279986, 1120.008792218884, 1121.43928035982, 1122.4892673833426, 818.705266104202, 820.9425340226187, 822.3462347433805, 824.0688022534557, 825.9628316725762, 19629.901850490798, 19658.70511942322, 19741.21035158592, 19858.503537411536, 20117.195312187494, 21150.365489035354, 21383.67924481134, 21807.890960545254, 21870.0, 21881.781182188293, 17753.911230443893, 17941.551461213443, 18007.909960450244, 18013.549661258443, 18055.729164062548, 3461.2558299965626, 3520.1903562180587, 3535.381308271042, 3535.911602209965, 3547.396942519778, 157164.0, 157182.0, 158839.0, 162141.0, 163317.0, 13636.386362613706, 13725.45098196081, 13879.653008674864, 13966.301684915714, 14106.788398174036, 31862.0, 32394.676053239167, 32415.351692966007, 32546.511802322984, 33760.831195843864, 9901.0, 9986.500674966368, 9990.0, 9990.950045249872, 9993.0, 5018.749062546858, 5052.469490703496, 5061.468545802712, 5067.949320506821, 5069.264956581275, 6184.8763024739255, 6266.843328916813, 6332.1135041094285, 6333.778317758856, 6338.271098823694, 1093.9507722152523, 1125.5104029747085, 1132.7904337697553, 1142.9142814288796, 1152.4871432212585, 701.5790525684548, 735.3198291580267, 735.7535225699344, 738.9963050184715, 753.6382536382567, 11445.198836081561, 11898.46456909441, 11972.820407693891, 11989.700257493458, 12052.457639406073, 654.9214094308713, 664.9468042556681, 666.4768156996831, 671.0672165689696, 675.5575098310615, 5585.748641311151, 5692.260006199168, 5693.231413759089, 5695.515881150066, 5800.53595712342, 156751.21624391805, 158248.0, 158606.0, 158896.205518974, 161410.0, 135592.0, 135812.0, 136155.31922340524, 140144.0, 140289.0, 118688.40655796666, 119177.40411297888, 119406.8059319413, 120624.3968780168, 122759.0, 10836.837447438453, 10955.233133680884, 10955.287906286067, 10978.670639880816, 11029.0, 55605.72197138988, 55732.72133639306, 56604.71697641486, 56729.0, 57544.0, 71617.0, 72162.63918680373, 72726.63636681782, 72929.27070729437, 75058.62470687611, 13530.526431574848, 13847.23840188759, 13874.930625347213, 13933.651658708613, 13937.860621394062, 16174.0, 16440.83559164441, 16564.171791410623, 16655.083970381744, 16731.24709388056, 14207.502737404142, 14364.138151710931, 14472.782908256175, 14493.057951233137, 14518.0, 14121.858781412055, 14195.574132776033, 14330.85669143337, 14440.566782996528, 14444.85555144435, 15083.0, 15448.691026179638, 15485.84514154844, 15493.535193944199, 15535.844641553891, 11971.880281197426, 12143.14997950135, 12295.815562766387, 12335.0, 12474.0, 11856.0, 11950.880491195325, 12009.219400738924, 12079.577214797791, 12191.939040304742], "value": 9451.38268359372, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1359.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 106.0, 105.0, 105.0, 116.0, 105.0, 105.0, 106.0, 107.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 112.0, 111.0, 116.0, 110.0, 115.0, 110.0, 110.0, 114.0, 120.0], "value": 113.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 162.0, 161.0, 161.0, 160.0, 161.0, 161.0, 163.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 73.0, 73.0, 73.0, 74.0, 74.0, 73.0, 74.0, 73.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 76.0, 77.0, 77.0, 78.0, 77.0, 78.0, 78.0, 78.0], "value": 77.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 113.0, 116.0, 115.0, 113.0, 113.0, 113.0, 114.0, 111.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 151.0, 150.0, 149.0, 148.0, 149.0, 148.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 97.0, 93.0, 93.0, 94.0, 94.0, 94.0, 96.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 47.0, 45.0, 45.0, 47.0, 45.0, 45.0, 44.0, 44.0, 45.0], "value": 45.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 39.0, 38.0, 39.0, 39.0, 38.0, 38.0, 38.0], "value": 38.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 73.0, 71.0, 72.0, 74.0, 71.0, 72.0, 71.0, 70.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 103.0, 109.0, 108.0, 105.0, 101.0, 106.0, 106.0, 106.0, 109.0], "value": 106.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 147.0, 158.0, 150.0, 148.0, 147.0, 145.0, 152.0, 146.0, 155.0], "value": 150.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 59.0, 59.0, 55.0, 58.0, 60.0, 58.0, 59.0, 59.0], "value": 58.5, "unit": "score"}]}]} 02:07:54 INFO - Return code: 0 02:07:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:07:54 INFO - # TBPL SUCCESS # 02:07:54 INFO - Running post-action listener: _package_coverage_data 02:07:54 INFO - Running post-action listener: _resource_record_post_action 02:07:54 INFO - [mozharness: 2017-10-04 09:07:54.735341Z] Finished run-tests step (success) 02:07:54 INFO - Running post-run listener: _resource_record_post_run 02:07:54 INFO - Total resource usage - Wall time: 1181s; CPU: 13.0%; Read bytes: 9265152; Write bytes: 473587712; Read time: 2256; Write time: 313064 02:07:54 INFO - TinderboxPrint: CPU usage
13.1% 02:07:54 INFO - TinderboxPrint: I/O read bytes / time
9,265,152 / 2,256 02:07:54 INFO - TinderboxPrint: I/O write bytes / time
473,587,712 / 313,064 02:07:54 INFO - TinderboxPrint: CPU idle
8,186.1 (86.9%) 02:07:54 INFO - TinderboxPrint: CPU user
1,180.3 (12.5%) 02:07:54 INFO - TinderboxPrint: Swap in / out
0 / 0 02:07:54 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 85372928; Read time: 184; Write time: 25348 02:07:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:07:54 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 9256960; Write bytes: 284221440; Read time: 1924; Write time: 166940 02:07:55 INFO - Running post-run listener: _upload_blobber_files 02:07:55 INFO - Blob upload gear active. 02:07:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:07:55 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 02:07:55 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:07:55 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:07:55 INFO - (blobuploader) - INFO - Open directory for files ... 02:07:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:07:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:07:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:07:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:56 INFO - (blobuploader) - INFO - Done attempting. 02:07:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:07:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:07:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:08:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:00 INFO - (blobuploader) - INFO - Done attempting. 02:08:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:08:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:08:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:01 INFO - (blobuploader) - INFO - Done attempting. 02:08:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:08:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:08:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:08:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:08:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:08:02 INFO - (blobuploader) - INFO - Done attempting. 02:08:02 INFO - (blobuploader) - INFO - Iteration through files over. 02:08:02 INFO - Return code: 0 02:08:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:08:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:08:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b09099f963eeb5c2f1921117182cd0247dc821caa90be94f250d8a6c421fe6e5c1918bc17856ec6f20fa8e5b1f256f38ee1711367b2f8157ae0680501359ccfc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7bd26a5e86481c59f791504f47641027139e7f55b167e55df39f97f3d7e9900e7f27f4f6b4e430467cc3b7ea2a192ce96864dde94be048aeda267ea4eb37718a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/47e3f938c4e0c48c9e6d4a068ff3a92c003e78d657e308bd58e775be2feb28793fa1851b3686cefac44379efea160a5bbdad3736f8926d1ba57c77e14e3f6561", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e66e523301e303ebf23cb03a2ca1fb9fa617f591a64dbc6f80aa0a0604a6994389c287bb4209e242a1e7140d6ac6caa4a7ba663b452e0cb8404b128bf7d9e729"} 02:08:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:08:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:08:02 INFO - Contents: 02:08:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b09099f963eeb5c2f1921117182cd0247dc821caa90be94f250d8a6c421fe6e5c1918bc17856ec6f20fa8e5b1f256f38ee1711367b2f8157ae0680501359ccfc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7bd26a5e86481c59f791504f47641027139e7f55b167e55df39f97f3d7e9900e7f27f4f6b4e430467cc3b7ea2a192ce96864dde94be048aeda267ea4eb37718a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/47e3f938c4e0c48c9e6d4a068ff3a92c003e78d657e308bd58e775be2feb28793fa1851b3686cefac44379efea160a5bbdad3736f8926d1ba57c77e14e3f6561", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e66e523301e303ebf23cb03a2ca1fb9fa617f591a64dbc6f80aa0a0604a6994389c287bb4209e242a1e7140d6ac6caa4a7ba663b452e0cb8404b128bf7d9e729"} 02:08:02 INFO - Running post-run listener: copy_logs_to_upload_dir 02:08:02 INFO - Copying logs to upload dir... 02:08:02 INFO - mkdir: /builds/slave/test/build/upload/logs 02:08:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.492540 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-10-04 02:08:02.380990) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 02:08:02.384550) ========= 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=923d835db2ba3686ebe126b700000192-1507086409.818686-525191384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b09099f963eeb5c2f1921117182cd0247dc821caa90be94f250d8a6c421fe6e5c1918bc17856ec6f20fa8e5b1f256f38ee1711367b2f8157ae0680501359ccfc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7bd26a5e86481c59f791504f47641027139e7f55b167e55df39f97f3d7e9900e7f27f4f6b4e430467cc3b7ea2a192ce96864dde94be048aeda267ea4eb37718a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/47e3f938c4e0c48c9e6d4a068ff3a92c003e78d657e308bd58e775be2feb28793fa1851b3686cefac44379efea160a5bbdad3736f8926d1ba57c77e14e3f6561", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e66e523301e303ebf23cb03a2ca1fb9fa617f591a64dbc6f80aa0a0604a6994389c287bb4209e242a1e7140d6ac6caa4a7ba663b452e0cb8404b128bf7d9e729"} build_url:https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011204 build_url: 'https://queue.taskcluster.net/v1/task/aszCTdw9TAurduR-fLv3-w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b09099f963eeb5c2f1921117182cd0247dc821caa90be94f250d8a6c421fe6e5c1918bc17856ec6f20fa8e5b1f256f38ee1711367b2f8157ae0680501359ccfc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7bd26a5e86481c59f791504f47641027139e7f55b167e55df39f97f3d7e9900e7f27f4f6b4e430467cc3b7ea2a192ce96864dde94be048aeda267ea4eb37718a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/47e3f938c4e0c48c9e6d4a068ff3a92c003e78d657e308bd58e775be2feb28793fa1851b3686cefac44379efea160a5bbdad3736f8926d1ba57c77e14e3f6561", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e66e523301e303ebf23cb03a2ca1fb9fa617f591a64dbc6f80aa0a0604a6994389c287bb4209e242a1e7140d6ac6caa4a7ba663b452e0cb8404b128bf7d9e729"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-04 02:08:02.413522) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 02:08:02.413829) ========= 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=923d835db2ba3686ebe126b700000192-1507086409.818686-525191384 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-04 02:08:02.496809) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 02:08:02.497140) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-04 02:08:02.497484) ========= ========= Total master_lag: 0.25 =========