builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1507721251.87 results: success (0) revision: 0aac8b210514c48af1ca90957d6a2216407b66ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:31.867007) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:31.867399) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:31.867685) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:31.885937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:31.886247) ========= 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=0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-11 04:27:32-- 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% 46.4M=0s 2017-10-11 04:27:32 (46.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145366 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:32.049263) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:32.049584) ========= 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=0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023082 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:32.105228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:32.105561) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0aac8b210514c48af1ca90957d6a2216407b66ba --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 0aac8b210514c48af1ca90957d6a2216407b66ba --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=0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-11 04:27:32,270 truncating revision to first 12 chars 2017-10-11 04:27:32,270 Setting DEBUG logging. 2017-10-11 04:27:32,270 attempt 1/10 2017-10-11 04:27:32,270 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0aac8b210514?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-11 04:27:32,909 unpacking tar archive at: mozilla-beta-0aac8b210514/testing/mozharness/ program finished with exit code 0 elapsedTime=0.913305 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:33.036988) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:33.037301) ========= script_repo_revision: 0aac8b210514c48af1ca90957d6a2216407b66ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:33.040689) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:33.040954) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-11 04:27:33.057178) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-10-11 04:27:33.057459) ========= /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=0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:27:33 INFO - MultiFileLogger online at 20171011 04:27:33 in /builds/slave/test 04:27: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 04:27:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:27:33 INFO - {'append_to_log': False, 04:27:33 INFO - 'base_work_dir': '/builds/slave/test', 04:27:33 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 04:27:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:27:33 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 04:27:33 INFO - 'buildbot_json_path': 'buildprops.json', 04:27:33 INFO - 'code_coverage': False, 04:27:33 INFO - 'config_files': ('talos/linux_config.py',), 04:27:33 INFO - 'default_actions': ('clobber', 04:27:33 INFO - 'read-buildbot-config', 04:27:33 INFO - 'download-and-extract', 04:27:33 INFO - 'populate-webroot', 04:27:33 INFO - 'create-virtualenv', 04:27:33 INFO - 'install', 04:27:33 INFO - 'setup-mitmproxy', 04:27:33 INFO - 'run-tests'), 04:27:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:27:33 INFO - 'disable_ccov_upload': False, 04:27:33 INFO - 'disable_stylo': False, 04:27:33 INFO - 'download_minidump_stackwalk': True, 04:27:33 INFO - 'download_symbols': 'ondemand', 04:27:33 INFO - 'enable_stylo': False, 04:27:33 INFO - 'enable_webrender': False, 04:27:33 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:27:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:27:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:27:33 INFO - 'gecko_profile': False, 04:27:33 INFO - 'gecko_profile_interval': 0, 04:27:33 INFO - 'installer_path': 'installer.exe', 04:27:33 INFO - 'log_level': 'info', 04:27:33 INFO - 'log_name': 'talos', 04:27:33 INFO - 'log_to_console': True, 04:27:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:27:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:27:33 INFO - 'opt_config_files': (), 04:27:33 INFO - 'pip_index': False, 04:27:33 INFO - 'suite': 'dromaeojs-e10s', 04:27:33 INFO - 'system_bits': '32', 04:27:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:27:33 INFO - 'title': 'talos-linux64-ix-058', 04:27:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:27:33 INFO - 'use_talos_json': True, 04:27:33 INFO - 'verify': 'False', 04:27:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:27:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:27:33 INFO - 'work_dir': 'build'} 04:27:33 INFO - [mozharness: 2017-10-11 11:27:33.368851Z] Running clobber step. 04:27:33 INFO - Running pre-action listener: _resource_record_pre_action 04:27:33 INFO - Running main action method: clobber 04:27:33 INFO - rmtree: /builds/slave/test/build 04:27:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:27:34 INFO - Running post-action listener: _resource_record_post_action 04:27:34 INFO - [mozharness: 2017-10-11 11:27:34.381625Z] Finished clobber step (success) 04:27:34 INFO - [mozharness: 2017-10-11 11:27:34.381720Z] Running read-buildbot-config step. 04:27:34 INFO - Running pre-action listener: _resource_record_pre_action 04:27:34 INFO - Running main action method: read_buildbot_config 04:27:34 INFO - Using buildbot properties: 04:27:34 INFO - { 04:27:34 INFO - "project": "", 04:27:34 INFO - "product": "firefox", 04:27:34 INFO - "who": "dgottwald@mozilla.com", 04:27:34 INFO - "installer_path": "public/build/target.tar.bz2", 04:27:34 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 04:27:34 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 04:27:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 04:27:34 INFO - "stage_platform": "linux64", 04:27:34 INFO - "basedir": "/builds/slave/test", 04:27:34 INFO - "buildnumber": 163, 04:27:34 INFO - "platform": "ubuntu64_hw", 04:27:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:27:34 INFO - "slavebuilddir": "test", 04:27:34 INFO - "taskId": "U0uHCPjQToKB1tc-tFDYOw", 04:27:34 INFO - "branch": "mozilla-beta", 04:27:34 INFO - "script_repo_revision": "production", 04:27:34 INFO - "revision": "0aac8b210514c48af1ca90957d6a2216407b66ba", 04:27:34 INFO - "slavename": "talos-linux64-ix-058", 04:27:34 INFO - "repo_path": "releases/mozilla-beta" 04:27:34 INFO - } 04:27:34 INFO - Finding installer, test and symbols from parent task. 04:27:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U0uHCPjQToKB1tc-tFDYOw'}, attempt #1 04:27:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U0uHCPjQToKB1tc-tFDYOw'}, attempt #1 04:27:35 INFO - Task dependencies: AgFmK7ikTrmnDqFk5RVXjA 04:27:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA'}, attempt #1 04:27:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.tar.bz2 04:27:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.test_packages.json 04:27:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.crashreporter-symbols.zip 04:27:35 INFO - Running post-action listener: _resource_record_post_action 04:27:35 INFO - [mozharness: 2017-10-11 11:27:35.706222Z] Finished read-buildbot-config step (success) 04:27:35 INFO - [mozharness: 2017-10-11 11:27:35.706437Z] Running download-and-extract step. 04:27:35 INFO - Running pre-action listener: _resource_record_pre_action 04:27:35 INFO - Running main action method: download_and_extract 04:27:35 INFO - mkdir: /builds/slave/test/build/tests 04:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:35 INFO - trying https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.test_packages.json 04:27:35 INFO - Downloading https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:27:36 INFO - Downloaded 989 bytes. 04:27:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:27:36 INFO - Using the following test package requirements: 04:27:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:27:36 INFO - u'common': [u'target.common.tests.zip'], 04:27:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:27:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:27:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:27:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:27:36 INFO - u'mozbase': [u'target.common.tests.zip'], 04:27:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:27:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:27:36 INFO - u'web-platform': [u'target.common.tests.zip', 04:27:36 INFO - u'target.web-platform.tests.tar.gz'], 04:27:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:27:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:27:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.common.tests.zip 04:27:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:27:36 INFO - Fetch https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.common.tests.zip into memory 04:27:37 INFO - Content-Length response header: 55177425 04:27:37 INFO - Bytes received: 55177425 04:27:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.talos.tests.zip 04:27:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:27:48 INFO - Fetch https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.talos.tests.zip into memory 04:27:48 INFO - Content-Length response header: 14509251 04:27:48 INFO - Bytes received: 14509251 04:27:49 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')]} 04:27:49 INFO - trying https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.tar.bz2 04:27:49 INFO - Downloading https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:27:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:27:50 INFO - Downloaded 53636338 bytes. 04:27:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.tar.bz2 04:27:50 INFO - mkdir: /builds/slave/test/properties 04:27:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:27:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:27:50 INFO - Contents: 04:27:50 INFO - build_url:https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.tar.bz2 04:27:50 INFO - Running post-action listener: _resource_record_post_action 04:27:50 INFO - Running post-action listener: find_tests_for_verification 04:27:50 INFO - Running post-action listener: set_extra_try_arguments 04:27:50 INFO - [mozharness: 2017-10-11 11:27:50.385796Z] Finished download-and-extract step (success) 04:27:50 INFO - [mozharness: 2017-10-11 11:27:50.385916Z] Running populate-webroot step. 04:27:50 INFO - Running pre-action listener: _resource_record_pre_action 04:27:50 INFO - Running main action method: populate_webroot 04:27:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:27:50 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:27:50 INFO - 'tests': ['tresize', 04:27:50 INFO - 'tcanvasmark']}, 04:27:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:27:50 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:27:50 INFO - 'tests': ['dromaeo_css', 04:27:50 INFO - 'kraken']}, 04:27:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:27:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:50 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:27:50 INFO - 'talos_options': ['--disable-stylo'], 04:27:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:27:50 INFO - 'tests': ['damp', 'tps']}, 04:27:50 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:27:50 INFO - 'talos_options': ['--disable-stylo'], 04:27:50 INFO - 'tests': ['damp', 'tps']}, 04:27:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:27:50 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:27:50 INFO - 'tests': ['dromaeo_dom']}, 04:27:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:27:50 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:27:50 INFO - 'tests': ['basic_compositor_video', 04:27:50 INFO - 'glvideo']}, 04:27:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:27:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:27:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:27:50 INFO - 'talos_options': ['--disable-stylo'], 04:27:50 INFO - 'tests': ['ts_paint_webext', 04:27:50 INFO - 'tp5o_webext']}, 04:27:50 INFO - 'other-e10s': {'tests': ['a11yr', 04:27:50 INFO - 'ts_paint', 04:27:50 INFO - 'tpaint', 04:27:50 INFO - 'sessionrestore', 04:27:50 INFO - 'sessionrestore_many_windows', 04:27:50 INFO - 'sessionrestore_no_auto_restore', 04:27:50 INFO - 'tabpaint']}, 04:27:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:27:50 INFO - 'tests': ['a11yr', 04:27:50 INFO - 'ts_paint', 04:27:50 INFO - 'tpaint', 04:27:50 INFO - 'sessionrestore', 04:27:50 INFO - 'sessionrestore_many_windows', 04:27:50 INFO - 'sessionrestore_no_auto_restore', 04:27:50 INFO - 'tabpaint']}, 04:27:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:27:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:27:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:27:50 INFO - 'tests': ['perf_reftest_singletons']}, 04:27:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:27:50 INFO - 'tests': ['bloom_basic']}, 04:27:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:27:50 INFO - 'tsvgr_opacity', 04:27:50 INFO - 'tart', 04:27:50 INFO - 'tscrollx', 04:27:50 INFO - 'tsvg_static']}, 04:27:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:27:50 INFO - 'tests': ['tsvgx', 04:27:50 INFO - 'tsvgr_opacity', 04:27:50 INFO - 'tart', 04:27:50 INFO - 'tscrollx', 04:27:50 INFO - 'tsvg_static']}, 04:27:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:27:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:27:50 INFO - 'talos_options': ['--disable-stylo'], 04:27:50 INFO - 'tests': ['tp5o']}, 04:27:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:27:50 INFO - 'talos_options': ['--mitmproxy', 04:27:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:27:50 INFO - '--firstNonBlankPaint'], 04:27:50 INFO - 'tests': ['tp6_google', 04:27:50 INFO - 'tp6_youtube', 04:27:50 INFO - 'tp6_amazon', 04:27:50 INFO - 'tp6_facebook']}, 04:27:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:27:50 INFO - 'talos_options': ['--disable-stylo', 04:27:50 INFO - '--mitmproxy', 04:27:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:27:50 INFO - '--firstNonBlankPaint'], 04:27:50 INFO - 'tests': ['tp6_google', 04:27:50 INFO - 'tp6_youtube', 04:27:50 INFO - 'tp6_amazon', 04:27:50 INFO - 'tp6_facebook']}, 04:27:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:27:50 INFO - 'talos_options': ['--stylo-threads=1', 04:27:50 INFO - '--mitmproxy', 04:27:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:27:50 INFO - '--firstNonBlankPaint'], 04:27:50 INFO - 'tests': ['tp6_google', 04:27:50 INFO - 'tp6_youtube', 04:27:50 INFO - 'tp6_amazon', 04:27:50 INFO - 'tp6_facebook']}, 04:27:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:27:50 INFO - 'talos_options': ['--xperf_path', 04:27:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:50 INFO - 'tests': ['tp5n']}, 04:27:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:27:50 INFO - 'talos_options': ['--disable-stylo', 04:27:50 INFO - '--xperf_path', 04:27:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:50 INFO - 'tests': ['tp5n']}}} 04:27:50 INFO - Running post-action listener: _resource_record_post_action 04:27:50 INFO - [mozharness: 2017-10-11 11:27:50.402531Z] Finished populate-webroot step (success) 04:27:50 INFO - [mozharness: 2017-10-11 11:27:50.402620Z] Running create-virtualenv step. 04:27:50 INFO - Running pre-action listener: _resource_record_pre_action 04:27:50 INFO - Running main action method: create_virtualenv 04:27:50 INFO - Creating virtualenv /builds/slave/test/build/venv 04:27:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:27:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:27:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:27:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:27:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:27:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:27:51 INFO - Installing pip...............done. 04:27:51 INFO - Return code: 0 04:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:27:51 INFO - Reading from file tmpfile_stdout 04:27:51 INFO - Output received: 04:27:51 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:27:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:27:51 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')]} 04:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:51 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')]} 04:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:51 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 0x17231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a92090>, '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 0x1a92d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8cf90>, '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': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', '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 04:27:51 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 04:27:51 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 04:27:51 INFO - Using env: {'DISPLAY': ':0', 04:27:51 INFO - 'HOME': '/home/cltbld', 04:27:51 INFO - 'LANG': 'en_US.UTF-8', 04:27:51 INFO - 'LANGUAGE': 'en_US:en', 04:27:51 INFO - 'LOGNAME': 'cltbld', 04:27:51 INFO - 'MAIL': '/var/mail/cltbld', 04:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:51 INFO - 'MOZ_NO_REMOTE': '1', 04:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:51 INFO - 'NO_EM_RESTART': '1', 04:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:51 INFO - 'PWD': '/builds/slave/test', 04:27:51 INFO - 'SHELL': '/bin/bash', 04:27:51 INFO - 'SHLVL': '1', 04:27:51 INFO - 'TERM': 'linux', 04:27:51 INFO - 'TMOUT': '86400', 04:27:51 INFO - 'USER': 'cltbld', 04:27:51 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', 04:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:51 INFO - '_': '/tools/buildbot/bin/python'} 04:27:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:27:52 INFO - Downloading/unpacking pip>=1.5 04:27:52 INFO - Running setup.py egg_info for package pip 04:27:52 INFO - warning: no files found matching 'pip/cacert.pem' 04:27:52 INFO - warning: no files found matching '*.html' under directory 'docs' 04:27:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:27:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:27:52 INFO - Installing collected packages: pip 04:27:52 INFO - Found existing installation: pip 1.1 04:27:52 INFO - Uninstalling pip: 04:27:52 INFO - Successfully uninstalled pip 04:27:52 INFO - Running setup.py install for pip 04:27:52 INFO - warning: no files found matching 'pip/cacert.pem' 04:27:52 INFO - warning: no files found matching '*.html' under directory 'docs' 04:27:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:27:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:27:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:27:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:27:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:27:52 INFO - Successfully installed pip 04:27:52 INFO - Cleaning up... 04:27:52 INFO - Return code: 0 04:27:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:27:52 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')]} 04:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:52 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')]} 04:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:52 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 0x17231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a92090>, '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 0x1a92d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8cf90>, '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': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', '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 04:27:52 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 04:27:52 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 04:27:52 INFO - Using env: {'DISPLAY': ':0', 04:27:52 INFO - 'HOME': '/home/cltbld', 04:27:52 INFO - 'LANG': 'en_US.UTF-8', 04:27:52 INFO - 'LANGUAGE': 'en_US:en', 04:27:52 INFO - 'LOGNAME': 'cltbld', 04:27:52 INFO - 'MAIL': '/var/mail/cltbld', 04:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:52 INFO - 'MOZ_NO_REMOTE': '1', 04:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:52 INFO - 'NO_EM_RESTART': '1', 04:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:52 INFO - 'PWD': '/builds/slave/test', 04:27:52 INFO - 'SHELL': '/bin/bash', 04:27:52 INFO - 'SHLVL': '1', 04:27:52 INFO - 'TERM': 'linux', 04:27:52 INFO - 'TMOUT': '86400', 04:27:52 INFO - 'USER': 'cltbld', 04:27:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', 04:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:52 INFO - '_': '/tools/buildbot/bin/python'} 04:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:52 INFO - Downloading/unpacking psutil>=3.1.1 04:27:52 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 04:27:52 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 04:27:52 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 04:27:52 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 04:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:54 INFO - Installing collected packages: psutil 04:27:54 INFO - Running setup.py install for psutil 04:27:54 INFO - building 'psutil._psutil_linux' extension 04:27:54 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 04:27:54 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 04:27:54 INFO - building 'psutil._psutil_posix' extension 04:27:54 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 04:27:54 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 04:27:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:54 INFO - Successfully installed psutil 04:27:54 INFO - Cleaning up... 04:27:54 INFO - Return code: 0 04:27:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:27: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')]} 04:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27: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')]} 04:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a92090>, '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 0x1a92d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8cf90>, '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': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', '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 04:27: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:27: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 mozsystemmonitor==0.3 04:27:54 INFO - Using env: {'DISPLAY': ':0', 04:27:54 INFO - 'HOME': '/home/cltbld', 04:27:54 INFO - 'LANG': 'en_US.UTF-8', 04:27:54 INFO - 'LANGUAGE': 'en_US:en', 04:27:54 INFO - 'LOGNAME': 'cltbld', 04:27:54 INFO - 'MAIL': '/var/mail/cltbld', 04:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:54 INFO - 'MOZ_NO_REMOTE': '1', 04:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:54 INFO - 'NO_EM_RESTART': '1', 04:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:54 INFO - 'PWD': '/builds/slave/test', 04:27:54 INFO - 'SHELL': '/bin/bash', 04:27:54 INFO - 'SHLVL': '1', 04:27:54 INFO - 'TERM': 'linux', 04:27:54 INFO - 'TMOUT': '86400', 04:27:54 INFO - 'USER': 'cltbld', 04:27:54 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', 04:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:54 INFO - '_': '/tools/buildbot/bin/python'} 04:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:27:54 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 04:27:54 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 04:27:54 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 04:27:54 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 04:27:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:27:56 INFO - Installing collected packages: mozsystemmonitor 04:27:56 INFO - Running setup.py install for mozsystemmonitor 04:27:56 INFO - Successfully installed mozsystemmonitor 04:27:56 INFO - Cleaning up... 04:27:57 INFO - Return code: 0 04:27:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a92090>, '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 0x1a92d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8cf90>, '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': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', '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 04:27:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:27:57 INFO - Using env: {'DISPLAY': ':0', 04:27:57 INFO - 'HOME': '/home/cltbld', 04:27:57 INFO - 'LANG': 'en_US.UTF-8', 04:27:57 INFO - 'LANGUAGE': 'en_US:en', 04:27:57 INFO - 'LOGNAME': 'cltbld', 04:27:57 INFO - 'MAIL': '/var/mail/cltbld', 04:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:57 INFO - 'MOZ_NO_REMOTE': '1', 04:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:57 INFO - 'NO_EM_RESTART': '1', 04:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:57 INFO - 'PWD': '/builds/slave/test', 04:27:57 INFO - 'SHELL': '/bin/bash', 04:27:57 INFO - 'SHLVL': '1', 04:27:57 INFO - 'TERM': 'linux', 04:27:57 INFO - 'TMOUT': '86400', 04:27:57 INFO - 'USER': 'cltbld', 04:27:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', 04:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:57 INFO - '_': '/tools/buildbot/bin/python'} 04:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:57 INFO - Downloading/unpacking jsonschema==2.5.1 04:27:57 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 04:27:57 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 04:27:57 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 04:27:57 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 04:27:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:27:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:27: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 04:27: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 04:27: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 04:27: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 04:27:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:27:58 INFO - warning: no files found matching '*.txt' 04:27:58 INFO - no previously-included directories found matching 'build' 04:27:58 INFO - no previously-included directories found matching 'dist' 04:27:58 INFO - no previously-included directories found matching '.git*' 04:27:58 INFO - Installing collected packages: jsonschema, functools32 04:27:59 INFO - Running setup.py install for functools32 04:27:59 INFO - warning: no files found matching '*.txt' 04:27:59 INFO - no previously-included directories found matching 'build' 04:27:59 INFO - no previously-included directories found matching 'dist' 04:27:59 INFO - no previously-included directories found matching '.git*' 04:27:59 INFO - Successfully installed jsonschema functools32 04:27:59 INFO - Cleaning up... 04:28:00 INFO - Return code: 0 04:28:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a92090>, '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 0x1a92d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8cf90>, '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': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', '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 04:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:28:00 INFO - Using env: {'DISPLAY': ':0', 04:28:00 INFO - 'HOME': '/home/cltbld', 04:28:00 INFO - 'LANG': 'en_US.UTF-8', 04:28:00 INFO - 'LANGUAGE': 'en_US:en', 04:28:00 INFO - 'LOGNAME': 'cltbld', 04:28:00 INFO - 'MAIL': '/var/mail/cltbld', 04:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:00 INFO - 'MOZ_NO_REMOTE': '1', 04:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:00 INFO - 'NO_EM_RESTART': '1', 04:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:00 INFO - 'PWD': '/builds/slave/test', 04:28:00 INFO - 'SHELL': '/bin/bash', 04:28:00 INFO - 'SHLVL': '1', 04:28:00 INFO - 'TERM': 'linux', 04:28:00 INFO - 'TMOUT': '86400', 04:28:00 INFO - 'USER': 'cltbld', 04:28:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', 04:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:00 INFO - '_': '/tools/buildbot/bin/python'} 04:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:28:00 INFO - Cleaning up... 04:28:00 INFO - Return code: 0 04:28:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a92090>, '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 0x1a92d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8cf90>, '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': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', '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 04:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:28:00 INFO - Using env: {'DISPLAY': ':0', 04:28:00 INFO - 'HOME': '/home/cltbld', 04:28:00 INFO - 'LANG': 'en_US.UTF-8', 04:28:00 INFO - 'LANGUAGE': 'en_US:en', 04:28:00 INFO - 'LOGNAME': 'cltbld', 04:28:00 INFO - 'MAIL': '/var/mail/cltbld', 04:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:00 INFO - 'MOZ_NO_REMOTE': '1', 04:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:00 INFO - 'NO_EM_RESTART': '1', 04:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:00 INFO - 'PWD': '/builds/slave/test', 04:28:00 INFO - 'SHELL': '/bin/bash', 04:28:00 INFO - 'SHLVL': '1', 04:28:00 INFO - 'TERM': 'linux', 04:28:00 INFO - 'TMOUT': '86400', 04:28:00 INFO - 'USER': 'cltbld', 04:28:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', 04:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:00 INFO - '_': '/tools/buildbot/bin/python'} 04:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:00 INFO - Downloading/unpacking blobuploader==1.2.4 04:28: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 04:28: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 04:28: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 04:28: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 04:28:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:28:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:28: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 04:28: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 04:28: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 04:28: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 04:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:28:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:28: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 04:28: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 04:28: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 04:28: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 04:28:02 INFO - Downloading docopt-0.6.1.tar.gz 04:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:28:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:28:02 INFO - Running setup.py install for blobuploader 04:28:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:28:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:28:02 INFO - Running setup.py install for requests 04:28:02 INFO - Running setup.py install for docopt 04:28:02 INFO - Successfully installed blobuploader requests docopt 04:28:02 INFO - Cleaning up... 04:28:02 INFO - Return code: 0 04:28:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28: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')]} 04:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28: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')]} 04:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:02 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 0x17231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a92090>, '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 0x1a92d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8cf90>, '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': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', '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 04:28:02 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 04:28:02 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 04:28:02 INFO - Using env: {'DISPLAY': ':0', 04:28:02 INFO - 'HOME': '/home/cltbld', 04:28:02 INFO - 'LANG': 'en_US.UTF-8', 04:28:02 INFO - 'LANGUAGE': 'en_US:en', 04:28:02 INFO - 'LOGNAME': 'cltbld', 04:28:02 INFO - 'MAIL': '/var/mail/cltbld', 04:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:02 INFO - 'MOZ_NO_REMOTE': '1', 04:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:02 INFO - 'NO_EM_RESTART': '1', 04:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:02 INFO - 'PWD': '/builds/slave/test', 04:28:02 INFO - 'SHELL': '/bin/bash', 04:28:02 INFO - 'SHLVL': '1', 04:28:02 INFO - 'TERM': 'linux', 04:28:02 INFO - 'TMOUT': '86400', 04:28:02 INFO - 'USER': 'cltbld', 04:28:02 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', 04:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:02 INFO - '_': '/tools/buildbot/bin/python'} 04:28:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:28:03 INFO - Running setup.py (path:/tmp/pip-Yaog_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:28:03 INFO - Running setup.py (path:/tmp/pip-YdLhzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:28:03 INFO - Running setup.py (path:/tmp/pip-TQL842-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:28:03 INFO - Running setup.py (path:/tmp/pip-bzqLig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:28:03 INFO - Running setup.py (path:/tmp/pip-71Jgo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:28:03 INFO - Running setup.py (path:/tmp/pip-aFLLPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:28:03 INFO - Running setup.py (path:/tmp/pip-PwsOAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:28:03 INFO - Running setup.py (path:/tmp/pip-iy5lOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:28:03 INFO - Running setup.py (path:/tmp/pip-qh1jHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:28:03 INFO - Running setup.py (path:/tmp/pip-SiDmXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:28:03 INFO - Running setup.py (path:/tmp/pip-TBUHjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:28:03 INFO - Running setup.py (path:/tmp/pip-beMMvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:28:03 INFO - Running setup.py (path:/tmp/pip-mfHnpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:28:04 INFO - Running setup.py (path:/tmp/pip-Ic6Ueu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:04 INFO - Running setup.py (path:/tmp/pip-1X1JhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:28:04 INFO - Running setup.py (path:/tmp/pip-EnKtpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:28:04 INFO - Running setup.py (path:/tmp/pip-dMpcrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:28:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:28:04 INFO - Running setup.py install for manifestparser 04:28:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:28:04 INFO - Running setup.py install for mozcrash 04:28:04 INFO - Running setup.py install for mozdebug 04:28:04 INFO - Running setup.py install for mozdevice 04:28:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:28:04 INFO - Running setup.py install for mozfile 04:28:04 INFO - Running setup.py install for mozhttpd 04:28:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:28:04 INFO - Running setup.py install for mozinfo 04:28:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:28:04 INFO - Running setup.py install for mozInstall 04:28:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Running setup.py install for mozleak 04:28:05 INFO - Running setup.py install for mozlog 04:28:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Running setup.py install for moznetwork 04:28:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Running setup.py install for mozprocess 04:28:05 INFO - Running setup.py install for mozprofile 04:28:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Running setup.py install for mozrunner 04:28:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:28:05 INFO - Running setup.py install for mozscreenshot 04:28:05 INFO - Running setup.py install for moztest 04:28:05 INFO - Running setup.py install for mozversion 04:28:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:28:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:28:06 INFO - Cleaning up... 04:28:06 INFO - Return code: 0 04:28:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:06 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 0x17231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a92090>, '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 0x1a92d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8cf90>, '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': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', '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 04:28:06 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 04:28:06 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 04:28:06 INFO - Using env: {'DISPLAY': ':0', 04:28:06 INFO - 'HOME': '/home/cltbld', 04:28:06 INFO - 'LANG': 'en_US.UTF-8', 04:28:06 INFO - 'LANGUAGE': 'en_US:en', 04:28:06 INFO - 'LOGNAME': 'cltbld', 04:28:06 INFO - 'MAIL': '/var/mail/cltbld', 04:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:06 INFO - 'MOZ_NO_REMOTE': '1', 04:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:06 INFO - 'NO_EM_RESTART': '1', 04:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:06 INFO - 'PWD': '/builds/slave/test', 04:28:06 INFO - 'SHELL': '/bin/bash', 04:28:06 INFO - 'SHLVL': '1', 04:28:06 INFO - 'TERM': 'linux', 04:28:06 INFO - 'TMOUT': '86400', 04:28:06 INFO - 'USER': 'cltbld', 04:28:06 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', 04:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:06 INFO - '_': '/tools/buildbot/bin/python'} 04:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:28:06 INFO - Running setup.py (path:/tmp/pip-xodiIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:28:06 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)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:28:06 INFO - Running setup.py (path:/tmp/pip-hKDADj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:28:06 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)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:28:06 INFO - Running setup.py (path:/tmp/pip-P_SgkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:28:06 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)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:28:06 INFO - Running setup.py (path:/tmp/pip-Bph40x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:28:06 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)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:28:06 INFO - Running setup.py (path:/tmp/pip-9tgA20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:28:06 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)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:28:06 INFO - Running setup.py (path:/tmp/pip-dfp1fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:28:06 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)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:28:06 INFO - Running setup.py (path:/tmp/pip-qDz8jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:28:06 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)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:28:06 INFO - Running setup.py (path:/tmp/pip-5Gm78h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:28:06 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)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:28:06 INFO - Running setup.py (path:/tmp/pip-KbQhIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:28:06 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)) 04:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:28:06 INFO - Running setup.py (path:/tmp/pip-_eJyUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:28:07 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)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:28:07 INFO - Running setup.py (path:/tmp/pip-5FRDEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:28:07 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)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:28:07 INFO - Running setup.py (path:/tmp/pip-o1sC7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:28:07 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)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:28:07 INFO - Running setup.py (path:/tmp/pip-vziiX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:28:07 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)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:28:07 INFO - Running setup.py (path:/tmp/pip-w5cX2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:28:07 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)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:07 INFO - Running setup.py (path:/tmp/pip-H_RwSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:28:07 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)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:28:07 INFO - Running setup.py (path:/tmp/pip-mtzngV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:28:07 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)) 04:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:28:07 INFO - Running setup.py (path:/tmp/pip-eY0J9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:28:07 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)) 04:28:07 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)) 04:28:07 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)) 04:28:07 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)) 04:28:07 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)) 04:28:07 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)) 04:28:07 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)) 04:28:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:28:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:28:08 INFO - Downloading blessings-1.6.tar.gz 04:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:28:08 INFO - Installing collected packages: blessings 04:28:08 INFO - Running setup.py install for blessings 04:28:08 INFO - Successfully installed blessings 04:28:08 INFO - Cleaning up... 04:28:08 INFO - Return code: 0 04:28:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:28:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:28:09 INFO - Reading from file tmpfile_stdout 04:28:09 INFO - Current package versions: 04:28:09 INFO - argparse == 1.2.1 04:28:09 INFO - blessings == 1.6 04:28:09 INFO - blobuploader == 1.2.4 04:28:09 INFO - docopt == 0.6.1 04:28:09 INFO - functools32 == 3.2.3-2 04:28:09 INFO - jsonschema == 2.5.1 04:28:09 INFO - manifestparser == 1.1 04:28:09 INFO - mozInstall == 1.13 04:28:09 INFO - mozcrash == 1.0 04:28:09 INFO - mozdebug == 0.1 04:28:09 INFO - mozdevice == 0.51 04:28:09 INFO - mozfile == 1.2 04:28:09 INFO - mozhttpd == 0.7 04:28:09 INFO - mozinfo == 0.10 04:28:09 INFO - mozleak == 0.1 04:28:09 INFO - mozlog == 3.5 04:28:09 INFO - moznetwork == 0.27 04:28:09 INFO - mozprocess == 0.25 04:28:09 INFO - mozprofile == 0.28 04:28:09 INFO - mozrunner == 6.13 04:28:09 INFO - mozscreenshot == 0.1 04:28:09 INFO - mozsystemmonitor == 0.3 04:28:09 INFO - moztest == 0.8 04:28:09 INFO - mozversion == 1.4 04:28:09 INFO - psutil == 3.1.1 04:28:09 INFO - requests == 1.2.3 04:28:09 INFO - wsgiref == 0.1.2 04:28:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:09 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 0x17231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a92090>, '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 0x1a92d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8cf90>, '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': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', '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 04:28:09 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 04:28:09 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 04:28:09 INFO - Using env: {'DISPLAY': ':0', 04:28:09 INFO - 'HOME': '/home/cltbld', 04:28:09 INFO - 'LANG': 'en_US.UTF-8', 04:28:09 INFO - 'LANGUAGE': 'en_US:en', 04:28:09 INFO - 'LOGNAME': 'cltbld', 04:28:09 INFO - 'MAIL': '/var/mail/cltbld', 04:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:09 INFO - 'MOZ_NO_REMOTE': '1', 04:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:09 INFO - 'NO_EM_RESTART': '1', 04:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:09 INFO - 'PWD': '/builds/slave/test', 04:28:09 INFO - 'SHELL': '/bin/bash', 04:28:09 INFO - 'SHLVL': '1', 04:28:09 INFO - 'TERM': 'linux', 04:28:09 INFO - 'TMOUT': '86400', 04:28:09 INFO - 'USER': 'cltbld', 04:28:09 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', 04:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:09 INFO - '_': '/tools/buildbot/bin/python'} 04:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:09 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)) 04:28:09 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)) 04:28:09 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)) 04:28:09 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)) 04:28:09 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)) 04:28:09 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)) 04:28:09 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)) 04:28:09 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)) 04:28:09 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)) 04:28:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:28: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 04:28: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 04:28: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 04:28: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 04:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:28:10 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)) 04:28:10 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)) 04:28:10 INFO - Installing collected packages: simplejson 04:28:10 INFO - Running setup.py install for simplejson 04:28:10 INFO - building 'simplejson._speedups' extension 04:28:10 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 04:28:11 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 04:28:11 INFO - Successfully installed simplejson 04:28:11 INFO - Cleaning up... 04:28:11 INFO - Return code: 0 04:28:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:28:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17231f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18eba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a92090>, '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 0x1a92d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8cf90>, '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': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', '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 04:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:28:11 INFO - Using env: {'DISPLAY': ':0', 04:28:11 INFO - 'HOME': '/home/cltbld', 04:28:11 INFO - 'LANG': 'en_US.UTF-8', 04:28:11 INFO - 'LANGUAGE': 'en_US:en', 04:28:11 INFO - 'LOGNAME': 'cltbld', 04:28:11 INFO - 'MAIL': '/var/mail/cltbld', 04:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:11 INFO - 'MOZ_NO_REMOTE': '1', 04:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:11 INFO - 'NO_EM_RESTART': '1', 04:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:11 INFO - 'PWD': '/builds/slave/test', 04:28:11 INFO - 'SHELL': '/bin/bash', 04:28:11 INFO - 'SHLVL': '1', 04:28:11 INFO - 'TERM': 'linux', 04:28:11 INFO - 'TMOUT': '86400', 04:28:11 INFO - 'USER': 'cltbld', 04:28:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', 04:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:11 INFO - '_': '/tools/buildbot/bin/python'} 04:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:28:11 INFO - Cleaning up... 04:28:11 INFO - Return code: 0 04:28:11 INFO - Running post-action listener: _resource_record_post_action 04:28:11 INFO - Running post-action listener: _start_resource_monitoring 04:28:11 INFO - Starting resource monitoring. 04:28:11 INFO - [mozharness: 2017-10-11 11:28:11.830740Z] Finished create-virtualenv step (success) 04:28:11 INFO - [mozharness: 2017-10-11 11:28:11.831467Z] Running install step. 04:28:11 INFO - Running pre-action listener: _resource_record_pre_action 04:28:11 INFO - Running main action method: install 04:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:28:12 INFO - Reading from file tmpfile_stdout 04:28:12 INFO - Detecting whether we're running mozinstall >=1.0... 04:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:28:12 INFO - Reading from file tmpfile_stdout 04:28:12 INFO - Output received: 04:28:12 INFO - Usage: mozinstall [options] installer 04:28:12 INFO - Options: 04:28:12 INFO - -h, --help show this help message and exit 04:28:12 INFO - -d DEST, --destination=DEST 04:28:12 INFO - Directory to install application into. [default: 04:28:12 INFO - "/builds/slave/test"] 04:28:12 INFO - --app=APP Application being installed. [default: firefox] 04:28:12 INFO - mkdir: /builds/slave/test/build/application 04:28:12 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'] 04:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:28:26 INFO - Reading from file tmpfile_stdout 04:28:26 INFO - Output received: 04:28:26 INFO - /builds/slave/test/build/application/firefox/firefox 04:28:26 INFO - Running post-action listener: _resource_record_post_action 04:28:26 INFO - [mozharness: 2017-10-11 11:28:26.806849Z] Finished install step (success) 04:28:26 INFO - [mozharness: 2017-10-11 11:28:26.807113Z] Running setup-mitmproxy step. 04:28:26 INFO - Running pre-action listener: _resource_record_pre_action 04:28:26 INFO - Running main action method: setup_mitmproxy 04:28:26 INFO - Skipping: mitmproxy is not required 04:28:26 INFO - Running post-action listener: _resource_record_post_action 04:28:26 INFO - [mozharness: 2017-10-11 11:28:26.808234Z] Finished setup-mitmproxy step (success) 04:28:26 INFO - [mozharness: 2017-10-11 11:28:26.808453Z] Running run-tests step. 04:28:26 INFO - Running pre-action listener: _resource_record_pre_action 04:28:26 INFO - Running pre-action listener: _set_gcov_prefix 04:28:26 INFO - Running main action method: run_tests 04:28:26 WARNING - Try message not found. 04:28:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:28:26 INFO - Python 2.7.3 04:28:26 INFO - Return code: 0 04:28:26 INFO - grabbing minidump binary from tooltool 04:28:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:28:26 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 0x1a92090>, '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 0x1a92d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:28:26 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 04:28:26 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 04:28:26 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 04:28:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:28:26 INFO - Return code: 0 04:28:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:28:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:28:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:28:26 INFO - ENV: RUST_BACKTRACE is now full 04:28:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:28:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:28:26 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/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 04:28:26 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/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 04:28:26 INFO - Using env: {'DISPLAY': ':0', 04:28:26 INFO - 'HOME': '/home/cltbld', 04:28:26 INFO - 'LANG': 'en_US.UTF-8', 04:28:26 INFO - 'LANGUAGE': 'en_US:en', 04:28:26 INFO - 'LOGNAME': 'cltbld', 04:28:26 INFO - 'MAIL': '/var/mail/cltbld', 04:28:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:26 INFO - 'MOZ_NO_REMOTE': '1', 04:28:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:26 INFO - 'NO_EM_RESTART': '1', 04:28:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:26 INFO - 'PWD': '/builds/slave/test', 04:28:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:26 INFO - 'RUST_BACKTRACE': 'full', 04:28:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:28:26 INFO - 'SHELL': '/bin/bash', 04:28:26 INFO - 'SHLVL': '1', 04:28:26 INFO - 'TERM': 'linux', 04:28:26 INFO - 'TMOUT': '86400', 04:28:26 INFO - 'USER': 'cltbld', 04:28:26 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', 04:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:26 INFO - '_': '/tools/buildbot/bin/python'} 04:28:26 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/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 04:28:27 INFO - mozversion application_buildid: 20171011095853 04:28:27 INFO - mozversion application_changeset: 0aac8b210514c48af1ca90957d6a2216407b66ba 04:28:27 INFO - mozversion application_display_name: Firefox 04:28:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:28:27 INFO - mozversion application_name: Firefox 04:28:27 INFO - mozversion application_remotingname: firefox 04:28:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:28:27 INFO - mozversion application_vendor: Mozilla 04:28:27 INFO - mozversion application_version: 57.0 04:28:27 INFO - mozversion platform_buildid: 20171011095853 04:28:27 INFO - mozversion platform_changeset: 0aac8b210514c48af1ca90957d6a2216407b66ba 04:28:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:28:27 INFO - mozversion platform_version: 57.0 04:28:27 INFO - using testdate: 1507721307 04:28:27 INFO - actual date: 1507721307 04:28:27 INFO - starting webserver on 'localhost:36573' 04:28:27 INFO - SUITE-START | Running 2 tests 04:28:27 INFO - TEST-START | dromaeo_css 04:28:27 INFO - Initialising browser for dromaeo_css test... 04:28:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36573/getInfo.html -profile /tmp/tmpjHzWDK/profile 04:28:27 INFO - TEST-INFO | started process 18031 (/builds/slave/test/build/application/firefox/firefox http://localhost:36573/getInfo.html) 04:28:32 INFO - TEST-INFO | 18031: exit 0 04:28:32 INFO - Browser initialized. 04:28:32 INFO - Running cycle 1/1 for dromaeo_css test... 04:28:32 INFO - Using env: {'DISPLAY': ':0', 04:28:32 INFO - 'HOME': '/home/cltbld', 04:28:32 INFO - 'JSGC_DISABLE_POISONING': '1', 04:28:32 INFO - 'LANG': 'en_US.UTF-8', 04:28:32 INFO - 'LANGUAGE': 'en_US:en', 04:28:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:28:32 INFO - 'LOGNAME': 'cltbld', 04:28:32 INFO - 'MAIL': '/var/mail/cltbld', 04:28:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:28:32 INFO - 'MOZ_CRASHREPORTER': '1', 04:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:28:32 INFO - 'MOZ_NO_REMOTE': '1', 04:28:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:32 INFO - 'NO_EM_RESTART': '1', 04:28:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:32 INFO - 'PWD': '/builds/slave/test', 04:28:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:32 INFO - 'RUST_BACKTRACE': 'full', 04:28:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:28:32 INFO - 'SHELL': '/bin/bash', 04:28:32 INFO - 'SHLVL': '1', 04:28:32 INFO - 'TERM': 'linux', 04:28:32 INFO - 'TMOUT': '86400', 04:28:32 INFO - 'USER': 'cltbld', 04:28:32 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', 04:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:32 INFO - '_': '/tools/buildbot/bin/python'} 04:28:32 INFO - TEST-INFO | started process 18265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjHzWDK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:33 INFO - PID 18265 | 04:28:33 INFO - PID 18265 | (/builds/slave/test/build/application/firefox/firefox:18315): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:28:33 INFO - PID 18265 | 04:28:43 INFO - PID 18265 | RSS: Main: 141840384 04:28:43 INFO - PID 18265 | 04:31:40 INFO - PID 18265 | Cycle 1(1): loaded http://localhost:36573/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36573/tests/dromaeo/cssquery-ext.html) 04:31:42 INFO - PID 18265 | RSS: Main: 145350656 04:31:42 INFO - PID 18265 | 04:34:43 INFO - PID 18265 | Cycle 1(1): loaded http://localhost:36573/tests/dromaeo/cssquery-ext.html (next: http://localhost:36573/tests/dromaeo/cssquery-jquery.html) 04:34:44 INFO - PID 18265 | RSS: Main: 144052224 04:34:44 INFO - PID 18265 | 04:37:45 INFO - PID 18265 | Cycle 1(1): loaded http://localhost:36573/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36573/tests/dromaeo/cssquery-mootools.html) 04:37:46 INFO - PID 18265 | RSS: Main: 145362944 04:37:46 INFO - PID 18265 | 04:40:47 INFO - PID 18265 | Cycle 1(1): loaded http://localhost:36573/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36573/tests/dromaeo/cssquery-prototype.html) 04:40:48 INFO - PID 18265 | RSS: Main: 145268736 04:40:48 INFO - PID 18265 | 04:43:51 INFO - PID 18265 | Cycle 1(1): loaded http://localhost:36573/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36573/tests/dromaeo/cssquery-yui.html) 04:43:51 INFO - PID 18265 | RSS: Main: 146763776 04:43:51 INFO - PID 18265 | 04:46:53 INFO - PID 18265 | Cycle 1(1): loaded http://localhost:36573/tests/dromaeo/cssquery-yui.html (next: http://localhost:36573/tests/dromaeo/cssquery-dojo.html) 04:46:53 INFO - PID 18265 | RSS: Main: 149139456 04:46:53 INFO - PID 18265 | 04:46:53 INFO - PID 18265 | __start_tp_report 04:46:53 INFO - PID 18265 | _x_x_mozilla_page_load 04:46:53 INFO - PID 18265 | _x_x_mozilla_page_load_details 04:46:53 INFO - PID 18265 | |i|pagename|runs| 04:46:53 INFO - PID 18265 | |0;dojo.html;3981.0644498542847;4002.119533702586;4008.7193896427225;4014.839406423745;4023.476947996759;6465.191851018622;6562.47500199984;6623.370779775925;6626.8674626507445;6658.467322614191;6566.606003639785;6582.802515924518;6595.53831231814;6660.067590537316;6669.43309818666;5834.095715164135;5927.673977931212;5939.703014849262;5943.346231914507;5966.075258334943;5946.435088666592;5966.46301832835;5971.4625683688455;5974.163617093589;6078.939210607904;5981.49157321626;6053.606515576495;6066.545009124334;6073.7874174403905;6084.148219249309;5922.822315330547;5946.345901950782;5975.820725378246;5992.250968628921;6076.2404699412355;5772.336181339116;5775.768969241225;5848.590598658096;5850.180974663551;5944.554158438091;6429.646369449679;6509.414152726277;6521.706523206467;6532.771353002622;6567.211934567835;7101.2898710128575;7102.39629631482;7112.253213412569;7202.099737532809;7214.747483838093;7089.610071446068;7126.287371262884;7204.711811527585;7224.096987876515;7226.132864056294;6623.4701223901975;6768.052472653832;6770.69531871067;6786.117804685359;6787.321267873173;7366.558006519626;7399.926000740032;7403.703851845974;7409.110906691231;7486.775396738107;6970.546914450544;7026.156861176692;7054.012438258648;7077.716891324392;7192.784216473514;7117.181524124689;7118.430525557943;7119.252478489788;7120.145582530026;7154.642267886585;6936.098307220029;7121.9643901780155;7124.46566507514;7185.89221161683;7217.386522145572;7017.228104908456;7050.330218629325;7103.218645948941;7134.215236324;7139.178994415604;5176.767045482962;5215.6609820361555;5255.0540902637895;5282.683039017671;5309;4749.857504274877;4837.37114175155;4842.443119041285;4850.417949846041;4867.561919427269;6623.4701223901975;6626;6629.668516574152;6696;6722.9663851680425;7073.363397294268;7089.751858685025;7102.112235970504;7184.6048467334795;7193.604351760703;6690.464762818963;6698.028785826028;6729.831754206184;6745.3591908768585;6751.729930802713;5986.521078313812;5992.790252341147;6058.0610005449225;6072.726727297282;6074.787382441594;7386.372158366492;7391.260873912565;7488.513246638951;7501.812454688677;7529.849403012018;7137.072180616487;7157.856842863218;7162.928370716435;7192.352688258082;7195.568265904062;7462.44031697614;7481.513701609378;7559.395248380007;7572.053493313336;7572.39420846342;6919.377256046779;6987.965060174666;7022.6488675565;7112.324329188718;7119.359257666835;7000.859982800417;7007.264237255014;7044.189918159477;7091.397231235403;7100.964495177491;6779.050932869303;6832.760853370109;6833.965830170818;6880.621565813928;6889;6897.48268879826;6985.720571177096;7011.964940175267;7019.2629773873;7043;6821.147356580427;6857;6925.89611155823;6930.06444130036;6969.02433659278;6817.7272909083085;6848.760293389708;6900.413464855544;6940.167179938439;7012.4390048796995;6742.5280230383405;6835.179778426422;6848.212455567674;6851.2121106071445;6861.245263020964 04:46:53 INFO - PID 18265 | |1;ext.html;952.9190018848398;975.1467465967279;1009.5507499162876;1012.6607586458535;1015.5886865819341;45966.54033459664;46502.76748616252;46613.533864661345;46657.7667111664;46807.29789053163;43520.347194792026;43543.56456435435;43686;43940.78029609856;47837.28244076342;8734.65061397545;8846.734597962039;8891.510966896818;8893.555322233895;8900.910990890074;8321.625526851307;8383.371247156458;8392.076871544125;8403.41176117672;8405.831883362329;8391.70629027984;8405.705800296992;8436.029856566482;8457.57712114395;8471.025832029303;8326.958365208196;8335.708250211244;8374.623141958657;8396.286315663176;8411.873821892677;8668.133186681345;8669.21977022071;8678.218960293541;8679.609417576225;8735.039145693969;42645.57354426447;42903;42960;42993;43046.78476607597;3630.709543236535;3637.781733095996;3655.9086022849374;3658.652428019334;3660.3411385950517;35208.823955880056;35340.46989295162;35354.469682954776;35409.46885796715;35554.64445355539;5460.481254280877;5542.972285138549;5612.887742245173;5639;5663.971680141614;244854.99999999822;247140;247747;248514;248878;50074;50893.49106508961;56193.71903140458;56201;56394.154087688716;59522.40477595255;59872.70063649741;59889;60459.697701512094;60488.697556512816;18721.90639046796;18804.15381307817;18832;18864.245430182913;18917.810821891606;15540;15730;15823.762643560356;15850.920745396199;15867.365305387886;14079.296035198198;14267;14375.209363485108;14407.135571865512;14444.638884027983;5347.705876176848;5434.592405569598;5448.400675925645;5518.503334699816;5518.613697041169;1128.633194211868;1131.4455916600807;1132.3319241647469;1142.4687520303098;1150.2293463379556;26092;26552.867235664085;26819.463610727675;26923.461530769666;27324;1230.1081715756184;1234.4013153620488;1237.6905773556612;1245.6014075495755;1249.138094714644;13754.65613359674;13778.379972901244;14231.43074277038;14377.496787612383;14465.566033019026;296434;298888;305487;305623;310091;63968;64384;64471.032934506016;64520;64702.67648661727;1536.078352988198;1536.247238852954;1542.9382824686886;1544.5520798968398;1564.8435156484488;30139.397212056076;30393;30579.388412232074;30713;30915.845420772752;43536.78231608822;43582.56417435785;43602.56397435985;43607.56392436162;43652.345214821165;250204;251057;251859;252549;252782;36138.8193059033;36329.45505817362;36508.81745591255;36712;37185;46755.29867051929;48148.5185148144;48421.27368089411;48888.2666760006;48904.75547622239;34188.82905585456;34192.48711269383;34662.30675386528;35090.649093508735;35443;34666;34802.651973479944;34833.12917177091;34918.47622285617;35490.8225458871;42148.367774482795;42399.788001059795;42638.57361426346;43155.78422107869;43406.78296608497;33597.66402335945;34118.31763364768;34410;34565.65434345725;34884.82557587196;25109.246722598353;25286.367840804127;25392.365190870376;25438.491230175663;25465.49069018572 04:46:53 INFO - PID 18265 | |2;jquery.html;629.3077614623913;636.9363063693631;639.7249182851372;640.5793065032724;645.6287634610101;23517.529649407043;24084.879575602143;24755.876220618873;24777.132800351992;25170.24489265325;25349.873250633766;26680.59979100315;26750;26756.732432675668;26764.19707408781;6542.934570654304;6652.833679158036;6662.566933149354;6689;6705.899411508832;6801.081853949728;6850.383465488105;6852.897206541906;6860.279670634562;6860.416864566518;6813.3527314905;6815.284395138513;6826.419754320888;6827.21487028993;6832.487563432737;6758.324167583251;6817.488688348344;6822;6825.215100263484;6825.556338837984;6325.87348253037;6386.393292637192;6391.776287829904;6412.326705695881;6422.775202867924;29963.700362996307;30882.845585772153;30904.14575125477;31053.534196987064;31855.84072079648;2370.8577485350934;2416.0094361311776;2424.5878200705924;2431.3556907419547;2441.9145329913545;20405.693914591295;20765.377038688865;21252.89373553138;21273.36179914605;21373.465663358384;2630.592258199982;2658.5081759874292;2681.4503026879443;2687.932801679954;2701.8784154713085;138379;141780;160148;165223;165893.17053414776;15855.688344404523;16454.75317870233;16903.083920627683;16914.577135571464;17011.319547217972;27590.862045690046;27689.446211075665;27864.024759133332;27893.72106278952;27929.720702793118;11516.424178791027;11652;11668.066554675606;11755.471003804849;11894.88105118955;10656.733581660521;10678.62624808128;10724.78550428987;10775.515101820436;10816.67549973502;9815.901840981642;9900.702978910644;9981.950090249502;10153.340032897986;10218.948905255425;2951.4834903891733;3054.541818727209;3057.6636569977286;3106.1302835205724;3180.6349301337796;1056.963006294776;1058.7829494953517;1069.7967386196597;1076.0315715855793;1079.8920107989138;21095.156193752384;21781.673274900888;22034.669479957494;22069.006894689777;22070.779292207193;1117.379854180921;1126.9492872820742;1140.3443020263383;1145.4272863568217;1153.2849633227452;11817.172797904064;11954.701132471759;12038.337891416057;12056.397180140957;12202.816957745641;649511;667451;671755;684830;686660;129498;129896;131278.34360828134;132514.33742831225;134252;1156.6067537037447;1212.6847019774923;1213.3933033483258;1243.9253644781343;1293.9935300323439;22203;22676.546469070858;22851.657225141305;22919.312420627408;22958.311250662508;61155.69422152861;62466.687666561374;63134.68432657807;63288.68355658192;64427.35572644213;83707;83834.58082709792;83901;83961.16038839534;84922;16231.350745970502;16502.917485412498;16509;16538.834611654212;16553;24726.876365618056;25092.749072509043;25174.24477265685;25242.368940775894;25271.87364063168;19927.60144797067;19932.800671993675;20222.292219772826;20242.08910598997;20323.187072516932;18271.451856444328;18291.359802407384;18631.81368186301;18669.626607468046;18686.719699204794;19890.204391824165;20070.49823754418;20377.79622203759;20382.490437739176;20701.792982069986;16253.837461625233;16293.185340733153;16338.918305408397;16371.42700005494;16381;20020.899895500428;20172.29396971099;20216.19135234574;20239.392818215478;20525.281615143398 04:46:53 INFO - PID 18265 | |3;mootools.html;1484.8069750932377;1534.3939144038104;1534.8388419215983;1538.230884557721;1545.2428310128034;17426.215820288086;18094;18130.456086317397;18133.909330453364;18171.273149074055;17678.292868285287;17816.554586135353;17816.64366712665;17831.910840445813;17854.553636159104;3117.6726443723423;3120.953185702216;3169.9207519811957;3170.429322721909;3182.0771976126894;3050.816950982948;3092.3660649566896;3105.580746599203;3105.736012438945;3105.937881242374;3089.1041597936683;3095.303556699736;3198.760092993023;3207.1180425382972;3209.7753157279;3162.0671901788915;3179.1893067267815;3188.21888637283;3191.3138675184946;3197.1207917822553;3080.522519009557;3083.6145481814774;3084.4447999360104;3085.6451508076634;3088.629364476255;16805.747913781302;17118.743218851727;17160.485185444457;17162.57093572658;17163.828361716474;9073.954630226806;9308.813823723556;9334.439933604006;9360;9370.39092458988;5479;5578.112963745264;5644.491995720405;5687.516561092312;5774.393688662672;2133.775953524873;2162.156758864044;2171.1966572368165;2221.533477969628;2223.4774827915426;32920.176995575064;32974.6702532974;33006.17484562905;33070;33221.16947076318;7734.4585878989055;7769.689212431439;7869.409794265453;8000.079990801132;8055.395845311625;20841.791582083984;20870.26954056601;20997.895010525153;21019.579608407745;21154.682679759815;8694.391392602458;8976.14726600985;8987.595558199897;8997.505137217517;9008.459492430475;8061.959690201512;8094.392920530984;8315.04376996641;8391;8406.831863362699;6287.811365659038;6336.239651241788;6366.427021568081;6438.291787903327;6692.364225398579;1714.691355555987;1758.5691505581215;1867.4584370532666;1887.603603243307;1899.069455966594;899.9055099214619;908.8046070094962;912.1471424218245;919.4483310013939;920.3281604428804;8707.869381959275;8756.56217189138;8757.430767000125;8764.255038321686;8858.335624828163;1093.9398333091756;1095.6548687163518;1100.6697990602788;1107.545906178463;1123.8089524780808;5096.541311282002;5233.345831771028;5244.921326180111;5258.053550360972;5304.336957880265;25981.22056338313;26682.866585666947;26988.460230795667;27784.166475005783;27994.440111197662;25649.61525577118;26835.865820670773;26955.460890782073;27304.180874573794;27477.587836182473;12818;12960.157589756636;12981.350932453339;13054.934725326313;13055.673608159683;8966.775830604287;8974.057723938893;8989.730308090768;9012.2790176787;9074.319426043205;22772.886135569217;23114.884425577766;23157.989461369914;23773.286801395985;23922.760772392052;24065.398365040313;24276.95004382152;24280.392990175387;24456.75543244616;24466.266012019667;13138.408771605109;13318.400671969592;13388.2636454992;13388.866111338762;13399.598012059654;15990.520284391487;16031.438899638923;16178.67642647117;16338.754918676466;16465.67068658644;12558.686032848886;12851.357432128543;12906.096573240158;13111.541096061592;13165.275909824668;12532.37338133108;12550.623481295575;13024.348782560644;13083;13212.537561185312;11764.470598823245;11769.293842369485;11790.587329443428;11902.880971190178;11962.282263064244;8731.694390696295;8738.606762695821;8789.604467799092;8840.160184782435;8979.14698103679;8482.194191551793;8651.740447786577;8683.913160868311;8761.824763504821;8811.030786613595 04:46:53 INFO - PID 18265 | |4;prototype.html;559.725734390149;559.9636023658462;579.3106203617697;586.6216290492632;603.5624172474957;6303;6330.968345158268;6385.776497822577;6437.5493715439825;6484.837879053026;6255.562110652256;6256.812295631127;6282.497400207983;6312.495000399968;6327.46216571592;5031;5196.428392876781;5200.297959775429;5224.6081543884175;5240.947590524084;5114.744262786864;5146.279520867081;5168.379794424674;5178.637495375326;5183.766730497118;5050.46970068143;5061.266116413118;5078.857257117156;5088.92366614501;5100.5154510321645;5100;5126.102931986925;5154.845354639348;5167.9224811627855;5206.349206349207;4673.719576825401;4709.481956984729;4722.197226471474;4742.336072949755;4749.192637251641;6142.8771424571705;6163.08944227291;6213.440790328847;6317.305096439388;6347.460465860361;5950.851228719273;5986.3714309997695;5996.430339117776;6014.12795144706;6027.547933904931;6759.763408280735;6766.221884483298;6813.148356455443;6835.248122706498;6881.380675739158;4911.8772030699165;5184.481551844785;5195.220716892496;5203;5210.895782084375;6840.657967101674;6844;6985.965070174617;7012.859742805166;7012.896131160632;5354.571634269249;5371.785128594891;5373.973130134403;5384.892302154013;5407.648502847381;5415.512603865593;5445;5448.964696707613;5471.206675032098;5488.533474654699;6004.42957918997;6011.579189456696;6038.969805150946;6067.514598832171;6083.574149809471;6876.421341996751;6895.586264824126;6906.102206713095;6914.619695916773;6916.896246556305;1851.3982955539504;1857.4056301983505;1865.8973756443527;1876.9249230030646;1883.8696781930732;1295.0999055656416;1310.8230388897568;1334.4395353951363;1351.6080336702444;1352.3508715816463;6206.72069756862;6235.3452887446165;6248.9062664060075;6304.621722696561;6343.682815859189;6765.560238584575;6786.423154031864;6841.17905851301;6851.554648947803;6925.887604280642;6296;6302.306746257908;6317.368263173646;6325.683715814283;6362.872742545123;3611.4582812578324;3638.381475149231;3645.85416583339;3652.374693261473;3671.3024525340634;7133.822919218374;7138.643067846587;7194.784156475314;7216.654587259161;7281.854362912712;7101.857962840714;7110.324519170774;7123.89314160288;7153.96423017892;7156.570605763567;7216.603086830275;7225.963870180615;7283.708651653875;7293.598852063187;7301.634918254066;6825.829354266183;6949.583025018515;6956.37392634645;6965.825854353681;7005.6146911918295;6843.828904277433;6868.278830722902;6877.552959057845;6886.827829304308;6916.51584389108;7119.1457025157315;7135.821604459722;7166.89249661266;7190.42476601881;7221.241769614115;5287.259783630372;5365.248865158803;5368.973155134199;5398.4871437213405;5417.345500704705;6644.468442524683;6660.733570657313;6823.829404264735;6862.897056544056;6971.198312193959;6608.636524991171;6616.636085015371;6647.401733843977;6677.76627818024;6732.293109223461;6554.672266386567;6556.213254409501;6664.633445160369;6679.4656427484715;6709.228438729609;6313.779017734358;6560.507961902781;6640.667966601554;6663.800085997428;6679.265280819203;6670.933290667225;6695.296993815579;6720.428763555153;6808;6832;6555.344465553407;6560.8359791005605;6609.20689517261;6633.1376920999965;6653.900191497229 04:46:53 INFO - PID 18265 | |5;yui.html;946.1201082992818;964.2286171063148;964.8552717092435;976.5898322704463;978.4667356290821;20556;21236.25673101438;21273.36179914605;21367.35897923061;21453.249136280232;20052.298169564066;20263.898680506612;20398.490037749063;20435.897820510912;20439.386818395436;1036.4506811389938;1071.8124328242566;1073.6349641122017;1073.9624113156042;1075.3225467955178;1091.939943303118;1092.6776600902713;1092.721356054209;1097.462243500683;1102.9852535667205;1107.9169062320318;1150.844635974141;1151.130896173392;1153.2388623508486;1154.4689442856254;1147.2428197389725;1150.223599070624;1151.6372342712061;1152.130141742987;1153.8730739618636;816.1756625807917;819.7540737778643;819.8524265632184;823.5882058970515;829.8215883584998;21520.139194432202;21882.89058554713;22273.44316392087;22292.66561001586;22551.436214094614;23449.76550234493;23517.529649407086;23572.882135589385;23989.880050599637;24214.273571792874;17177.141142942804;17384.043877586853;17482.912585436992;17557;17560.209790559456;4127.587241275878;4210.789460526961;4230.132822771356;4237.364395340693;4237.915241695179;129816;145794.27102864525;161510;165236.17381913133;167360.16319918443;18070.638587228445;18542.907285463756;18578.814211857978;18631;18861.245550178115;34749.82625086858;34813.65186348155;34968.82515587406;35229.47155792665;35316;10680.89319106799;10708.19688523364;10709.571617135383;10742.355458672348;10744.785104297871;4814.735189564608;4827;4837.588804951619;4886.413630364379;4910.48439913811;6154;6336.619802811846;6338.70056638388;6358.904616430757;6362.77730279438;1226.9018478521875;1251.9123661343801;1272.6500212441654;1281.1352337172557;1285.9035572332114;654.5156584127711;657.5035847934779;674.0866126398757;678.9558678685969;691.3915754136328;12143.453544590515;12435.440405181607;12653.557125500563;12831.935840320739;13489.865101349058;696.9407600354027;713.9464540159405;718.9748358807417;726.6512074204411;734.346431675809;5542.445755424425;5606.747696353674;5636.154576813511;5637.746301416446;5704.857378565569;144486;146956;148745;149560;150754.24622877035;134811;135631.32184339015;137770;137816.31091844477;140111;119461;121154.67084201911;121730;122175.38912305381;123464;10758.40828754426;10802.351858888493;10917;10920.78158436811;10994.780104398027;56307.71846140743;56543.43456565381;56583;57108.42891571031;58378.7081064592;71458;71963.64018179875;72301.27698722946;73445.26554734384;75126;17000;17115.315387384366;17135.57161070983;17143.314267429163;17192.570185745455;18217.180226890086;18530.722039169694;18586.349477768214;18711.1579978904;19034.7144792831;16995.830041699424;17170.22733976949;17267;17440.47678569645;17571;15649.1392973383;16040.518784436486;16046.679066418374;16058.116803575915;16087.919560402122;16655.833441665913;17004.914975425043;17046.403375881786;17093.658126837643;17214.569635759206;11802.704932376759;12278.754424911273;12400.19398739079;12423;12551.497940082294;12320.507179712711;12428.937855310665;12437.564685235973;12485.687857803627;12535.749285014066 04:46:53 INFO - PID 18265 | __end_tp_report 04:46:53 INFO - PID 18265 | __start_cc_report 04:46:53 INFO - PID 18265 | _x_x_mozilla_cycle_collect,233 04:46:53 INFO - PID 18265 | __end_cc_report 04:46:53 INFO - PID 18265 | __startTimestamp1507722413602__endTimestamp 04:46:53 INFO - PID 18265 | 04:46:53 INFO - PID 18265 | ------- Summary: start ------- 04:46:53 INFO - PID 18265 | Number of tests: 6 04:46:53 INFO - PID 18265 | 04:46:53 INFO - PID 18265 | [#0] dojo.html Cycles:165 Average:6597.34 Median:6848.21 stddev:772.43 (11.3%) stddev-sans-first:747.04 04:46:53 INFO - PID 18265 | Values: 3981.1 4002.1 4008.7 4014.8 4023.5 6465.2 6562.5 6623.4 6626.9 6658.5 6566.6 6582.8 6595.5 6660.1 6669.4 5834.1 5927.7 5939.7 5943.3 5966.1 5946.4 5966.5 5971.5 5974.2 6078.9 5981.5 6053.6 6066.5 6073.8 6084.1 5922.8 5946.3 5975.8 5992.3 6076.2 5772.3 5775.8 5848.6 5850.2 5944.6 6429.6 6509.4 6521.7 6532.8 6567.2 7101.3 7102.4 7112.3 7202.1 7214.7 7089.6 7126.3 7204.7 7224.1 7226.1 6623.5 6768.1 6770.7 6786.1 6787.3 7366.6 7399.9 7403.7 7409.1 7486.8 6970.5 7026.2 7054.0 7077.7 7192.8 7117.2 7118.4 7119.3 7120.1 7154.6 6936.1 7122.0 7124.5 7185.9 7217.4 7017.2 7050.3 7103.2 7134.2 7139.2 5176.8 5215.7 5255.1 5282.7 5309.0 4749.9 4837.4 4842.4 4850.4 4867.6 6623.5 6626.0 6629.7 6696.0 6723.0 7073.4 7089.8 7102.1 7184.6 7193.6 6690.5 6698.0 6729.8 6745.4 6751.7 5986.5 5992.8 6058.1 6072.7 6074.8 7386.4 7391.3 7488.5 7501.8 7529.8 7137.1 7157.9 7162.9 7192.4 7195.6 7462.4 7481.5 7559.4 7572.1 7572.4 6919.4 6988.0 7022.6 7112.3 7119.4 7000.9 7007.3 7044.2 7091.4 7101.0 6779.1 6832.8 6834.0 6880.6 6889.0 6897.5 6985.7 7012.0 7019.3 7043.0 6821.1 6857.0 6925.9 6930.1 6969.0 6817.7 6848.8 6900.4 6940.2 7012.4 6742.5 6835.2 6848.2 6851.2 6861.2 04:46:53 INFO - PID 18265 | 04:46:53 INFO - PID 18265 | [#1] ext.html Cycles:180 Average:45367.30 Median:19983.62 stddev:69945.51 (350.0%) stddev-sans-first:70062.23 04:46:53 INFO - PID 18265 | Values: 952.9 975.1 1009.6 1012.7 1015.6 45966.5 46502.8 46613.5 46657.8 46807.3 43520.3 43543.6 43686.0 43940.8 47837.3 8734.7 8846.7 8891.5 8893.6 8900.9 8321.6 8383.4 8392.1 8403.4 8405.8 8391.7 8405.7 8436.0 8457.6 8471.0 8327.0 8335.7 8374.6 8396.3 8411.9 8668.1 8669.2 8678.2 8679.6 8735.0 42645.6 42903.0 42960.0 42993.0 43046.8 3630.7 3637.8 3655.9 3658.7 3660.3 35208.8 35340.5 35354.5 35409.5 35554.6 5460.5 5543.0 5612.9 5639.0 5664.0 244855.0 247140.0 247747.0 248514.0 248878.0 50074.0 50893.5 56193.7 56201.0 56394.2 59522.4 59872.7 59889.0 60459.7 60488.7 18721.9 18804.2 18832.0 18864.2 18917.8 15540.0 15730.0 15823.8 15850.9 15867.4 14079.3 14267.0 14375.2 14407.1 14444.6 5347.7 5434.6 5448.4 5518.5 5518.6 1128.6 1131.4 1132.3 1142.5 1150.2 26092.0 26552.9 26819.5 26923.5 27324.0 1230.1 1234.4 1237.7 1245.6 1249.1 13754.7 13778.4 14231.4 14377.5 14465.6 296434.0 298888.0 305487.0 305623.0 310091.0 63968.0 64384.0 64471.0 64520.0 64702.7 1536.1 1536.2 1542.9 1544.6 1564.8 30139.4 30393.0 30579.4 30713.0 30915.8 43536.8 43582.6 43602.6 43607.6 43652.3 250204.0 251057.0 251859.0 252549.0 252782.0 36138.8 36329.5 36508.8 36712.0 37185.0 46755.3 48148.5 48421.3 48888.3 48904.8 34188.8 34192.5 34662.3 35090.6 35443.0 34666.0 34802.7 34833.1 34918.5 35490.8 42148.4 42399.8 42638.6 43155.8 43406.8 33597.7 34118.3 34410.0 34565.7 34884.8 25109.2 25286.4 25392.4 25438.5 25465.5 04:46:53 INFO - PID 18265 | 04:46:53 INFO - PID 18265 | [#2] jquery.html Cycles:180 Average:42329.13 Median:22938.81 stddev:111841.06 (487.6%) stddev-sans-first:112110.98 04:46:53 INFO - PID 18265 | Values: 629.3 636.9 639.7 640.6 645.6 23517.5 24084.9 24755.9 24777.1 25170.2 25349.9 26680.6 26750.0 26756.7 26764.2 6542.9 6652.8 6662.6 6689.0 6705.9 6801.1 6850.4 6852.9 6860.3 6860.4 6813.4 6815.3 6826.4 6827.2 6832.5 6758.3 6817.5 6822.0 6825.2 6825.6 6325.9 6386.4 6391.8 6412.3 6422.8 29963.7 30882.8 30904.1 31053.5 31855.8 2370.9 2416.0 2424.6 2431.4 2441.9 20405.7 20765.4 21252.9 21273.4 21373.5 2630.6 2658.5 2681.5 2687.9 2701.9 138379.0 141780.0 160148.0 165223.0 165893.2 15855.7 16454.8 16903.1 16914.6 17011.3 27590.9 27689.4 27864.0 27893.7 27929.7 11516.4 11652.0 11668.1 11755.5 11894.9 10656.7 10678.6 10724.8 10775.5 10816.7 9815.9 9900.7 9982.0 10153.3 10218.9 2951.5 3054.5 3057.7 3106.1 3180.6 1057.0 1058.8 1069.8 1076.0 1079.9 21095.2 21781.7 22034.7 22069.0 22070.8 1117.4 1126.9 1140.3 1145.4 1153.3 11817.2 11954.7 12038.3 12056.4 12202.8 649511.0 667451.0 671755.0 684830.0 686660.0 129498.0 129896.0 131278.3 132514.3 134252.0 1156.6 1212.7 1213.4 1243.9 1294.0 22203.0 22676.5 22851.7 22919.3 22958.3 61155.7 62466.7 63134.7 63288.7 64427.4 83707.0 83834.6 83901.0 83961.2 84922.0 16231.4 16502.9 16509.0 16538.8 16553.0 24726.9 25092.7 25174.2 25242.4 25271.9 19927.6 19932.8 20222.3 20242.1 20323.2 18271.5 18291.4 18631.8 18669.6 18686.7 19890.2 20070.5 20377.8 20382.5 20701.8 16253.8 16293.2 16338.9 16371.4 16381.0 20020.9 20172.3 20216.2 20239.4 20525.3 04:46:53 INFO - PID 18265 | 04:46:53 INFO - PID 18265 | [#3] mootools.html Cycles:180 Average:11076.46 Median:3065.67 stddev:8339.43 (272.0%) stddev-sans-first:8331.69 04:46:53 INFO - PID 18265 | Values: 1484.8 1534.4 1534.8 1538.2 1545.2 17426.2 18094.0 18130.5 18133.9 18171.3 17678.3 17816.6 17816.6 17831.9 17854.6 3117.7 3121.0 3169.9 3170.4 3182.1 3050.8 3092.4 3105.6 3105.7 3105.9 3089.1 3095.3 3198.8 3207.1 3209.8 3162.1 3179.2 3188.2 3191.3 3197.1 3080.5 3083.6 3084.4 3085.6 3088.6 16805.7 17118.7 17160.5 17162.6 17163.8 9074.0 9308.8 9334.4 9360.0 9370.4 5479.0 5578.1 5644.5 5687.5 5774.4 2133.8 2162.2 2171.2 2221.5 2223.5 32920.2 32974.7 33006.2 33070.0 33221.2 7734.5 7769.7 7869.4 8000.1 8055.4 20841.8 20870.3 20997.9 21019.6 21154.7 8694.4 8976.1 8987.6 8997.5 9008.5 8062.0 8094.4 8315.0 8391.0 8406.8 6287.8 6336.2 6366.4 6438.3 6692.4 1714.7 1758.6 1867.5 1887.6 1899.1 899.9 908.8 912.1 919.4 920.3 8707.9 8756.6 8757.4 8764.3 8858.3 1093.9 1095.7 1100.7 1107.5 1123.8 5096.5 5233.3 5244.9 5258.1 5304.3 25981.2 26682.9 26988.5 27784.2 27994.4 25649.6 26835.9 26955.5 27304.2 27477.6 12818.0 12960.2 12981.4 13054.9 13055.7 8966.8 8974.1 8989.7 9012.3 9074.3 22772.9 23114.9 23158.0 23773.3 23922.8 24065.4 24277.0 24280.4 24456.8 24466.3 13138.4 13318.4 13388.3 13388.9 13399.6 15990.5 16031.4 16178.7 16338.8 16465.7 12558.7 12851.4 12906.1 13111.5 13165.3 12532.4 12550.6 13024.3 13083.0 13212.5 11764.5 11769.3 11790.6 11902.9 11962.3 8731.7 8738.6 8789.6 8840.2 8979.1 8482.2 8651.7 8683.9 8761.8 8811.0 04:46:53 INFO - PID 18265 | 04:46:53 INFO - PID 18265 | [#4] prototype.html Cycles:180 Average:5767.78 Median:6317.34 stddev:1602.86 (25.4%) stddev-sans-first:1558.96 04:46:53 INFO - PID 18265 | Values: 559.7 560.0 579.3 586.6 603.6 6303.0 6331.0 6385.8 6437.5 6484.8 6255.6 6256.8 6282.5 6312.5 6327.5 5031.0 5196.4 5200.3 5224.6 5240.9 5114.7 5146.3 5168.4 5178.6 5183.8 5050.5 5061.3 5078.9 5088.9 5100.5 5100.0 5126.1 5154.8 5167.9 5206.3 4673.7 4709.5 4722.2 4742.3 4749.2 6142.9 6163.1 6213.4 6317.3 6347.5 5950.9 5986.4 5996.4 6014.1 6027.5 6759.8 6766.2 6813.1 6835.2 6881.4 4911.9 5184.5 5195.2 5203.0 5210.9 6840.7 6844.0 6986.0 7012.9 7012.9 5354.6 5371.8 5374.0 5384.9 5407.6 5415.5 5445.0 5449.0 5471.2 5488.5 6004.4 6011.6 6039.0 6067.5 6083.6 6876.4 6895.6 6906.1 6914.6 6916.9 1851.4 1857.4 1865.9 1876.9 1883.9 1295.1 1310.8 1334.4 1351.6 1352.4 6206.7 6235.3 6248.9 6304.6 6343.7 6765.6 6786.4 6841.2 6851.6 6925.9 6296.0 6302.3 6317.4 6325.7 6362.9 3611.5 3638.4 3645.9 3652.4 3671.3 7133.8 7138.6 7194.8 7216.7 7281.9 7101.9 7110.3 7123.9 7154.0 7156.6 7216.6 7226.0 7283.7 7293.6 7301.6 6825.8 6949.6 6956.4 6965.8 7005.6 6843.8 6868.3 6877.6 6886.8 6916.5 7119.1 7135.8 7166.9 7190.4 7221.2 5287.3 5365.2 5369.0 5398.5 5417.3 6644.5 6660.7 6823.8 6862.9 6971.2 6608.6 6616.6 6647.4 6677.8 6732.3 6554.7 6556.2 6664.6 6679.5 6709.2 6313.8 6560.5 6640.7 6663.8 6679.3 6670.9 6695.3 6720.4 6808.0 6832.0 6555.3 6560.8 6609.2 6633.1 6653.9 04:46:53 INFO - PID 18265 | 04:46:53 INFO - PID 18265 | [#5] yui.html Cycles:180 Average:28443.98 Median:17461.69 stddev:42606.34 (244.0%) stddev-sans-first:42675.83 04:46:53 INFO - PID 18265 | Values: 946.1 964.2 964.9 976.6 978.5 20556.0 21236.3 21273.4 21367.4 21453.2 20052.3 20263.9 20398.5 20435.9 20439.4 1036.5 1071.8 1073.6 1074.0 1075.3 1091.9 1092.7 1092.7 1097.5 1103.0 1107.9 1150.8 1151.1 1153.2 1154.5 1147.2 1150.2 1151.6 1152.1 1153.9 816.2 819.8 819.9 823.6 829.8 21520.1 21882.9 22273.4 22292.7 22551.4 23449.8 23517.5 23572.9 23989.9 24214.3 17177.1 17384.0 17482.9 17557.0 17560.2 4127.6 4210.8 4230.1 4237.4 4237.9 129816.0 145794.3 161510.0 165236.2 167360.2 18070.6 18542.9 18578.8 18631.0 18861.2 34749.8 34813.7 34968.8 35229.5 35316.0 10680.9 10708.2 10709.6 10742.4 10744.8 4814.7 4827.0 4837.6 4886.4 4910.5 6154.0 6336.6 6338.7 6358.9 6362.8 1226.9 1251.9 1272.7 1281.1 1285.9 654.5 657.5 674.1 679.0 691.4 12143.5 12435.4 12653.6 12831.9 13489.9 696.9 713.9 719.0 726.7 734.3 5542.4 5606.7 5636.2 5637.7 5704.9 144486.0 146956.0 148745.0 149560.0 150754.2 134811.0 135631.3 137770.0 137816.3 140111.0 119461.0 121154.7 121730.0 122175.4 123464.0 10758.4 10802.4 10917.0 10920.8 10994.8 56307.7 56543.4 56583.0 57108.4 58378.7 71458.0 71963.6 72301.3 73445.3 75126.0 17000.0 17115.3 17135.6 17143.3 17192.6 18217.2 18530.7 18586.3 18711.2 19034.7 16995.8 17170.2 17267.0 17440.5 17571.0 15649.1 16040.5 16046.7 16058.1 16087.9 16655.8 17004.9 17046.4 17093.7 17214.6 11802.7 12278.8 12400.2 12423.0 12551.5 12320.5 12428.9 12437.6 12485.7 12535.7 04:46:53 INFO - PID 18265 | -------- Summary: end -------- 04:46:53 INFO - PID 18265 | 04:46:54 INFO - TEST-INFO | 18265: exit 0 04:46:54 INFO - TEST-OK | dromaeo_css | took 1107017ms 04:46:54 INFO - TEST-START | kraken 04:46:54 INFO - Initialising browser for kraken test... 04:46:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36573/getInfo.html -profile /tmp/tmpqxppiz/profile 04:46:54 INFO - TEST-INFO | started process 18632 (/builds/slave/test/build/application/firefox/firefox http://localhost:36573/getInfo.html) 04:46:59 INFO - TEST-INFO | 18632: exit 0 04:46:59 INFO - Browser initialized. 04:46:59 INFO - Running cycle 1/1 for kraken test... 04:46:59 INFO - Using env: {'DISPLAY': ':0', 04:46:59 INFO - 'HOME': '/home/cltbld', 04:46:59 INFO - 'JSGC_DISABLE_POISONING': '1', 04:46:59 INFO - 'LANG': 'en_US.UTF-8', 04:46:59 INFO - 'LANGUAGE': 'en_US:en', 04:46:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:46:59 INFO - 'LOGNAME': 'cltbld', 04:46:59 INFO - 'MAIL': '/var/mail/cltbld', 04:46:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:46:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:46:59 INFO - 'MOZ_CRASHREPORTER': '1', 04:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:46:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:46:59 INFO - 'MOZ_NO_REMOTE': '1', 04:46:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:46:59 INFO - 'NO_EM_RESTART': '1', 04:46:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:46:59 INFO - 'PWD': '/builds/slave/test', 04:46:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:46:59 INFO - 'RUST_BACKTRACE': 'full', 04:46:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:46:59 INFO - 'SHELL': '/bin/bash', 04:46:59 INFO - 'SHLVL': '1', 04:46:59 INFO - 'TERM': 'linux', 04:46:59 INFO - 'TMOUT': '86400', 04:46:59 INFO - 'USER': 'cltbld', 04:46:59 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105', 04:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:46:59 INFO - '_': '/tools/buildbot/bin/python'} 04:46:59 INFO - TEST-INFO | started process 18866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqxppiz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:00 INFO - PID 18866 | 04:47:00 INFO - PID 18866 | (/builds/slave/test/build/application/firefox/firefox:18913): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:47:00 INFO - PID 18866 | 04:47:10 INFO - PID 18866 | RSS: Main: 141643776 04:47:10 INFO - PID 18866 | 04:47:12 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36573/tests/kraken/driver.html?testName=audio-beat-detection) 04:47:13 INFO - PID 18866 | RSS: Main: 147595264 04:47:13 INFO - PID 18866 | 04:47:16 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36573/tests/kraken/driver.html?testName=audio-dft) 04:47:16 INFO - PID 18866 | RSS: Main: 148295680 04:47:16 INFO - PID 18866 | 04:47:19 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36573/tests/kraken/driver.html?testName=audio-fft) 04:47:20 INFO - PID 18866 | RSS: Main: 149348352 04:47:20 INFO - PID 18866 | 04:47:22 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36573/tests/kraken/driver.html?testName=audio-oscillator) 04:47:23 INFO - PID 18866 | RSS: Main: 150093824 04:47:23 INFO - PID 18866 | 04:47:25 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36573/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:47:25 INFO - PID 18866 | RSS: Main: 149479424 04:47:25 INFO - PID 18866 | 04:47:28 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36573/tests/kraken/driver.html?testName=imaging-darkroom) 04:47:29 INFO - PID 18866 | RSS: Main: 149516288 04:47:29 INFO - PID 18866 | 04:47:32 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36573/tests/kraken/driver.html?testName=imaging-desaturate) 04:47:33 INFO - PID 18866 | RSS: Main: 152346624 04:47:33 INFO - PID 18866 | 04:47:36 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36573/tests/kraken/driver.html?testName=json-parse-financial) 04:47:36 INFO - PID 18866 | RSS: Main: 152358912 04:47:36 INFO - PID 18866 | 04:47:38 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36573/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:47:38 INFO - PID 18866 | RSS: Main: 152403968 04:47:38 INFO - PID 18866 | 04:47:40 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36573/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:47:41 INFO - PID 18866 | RSS: Main: 152457216 04:47:41 INFO - PID 18866 | 04:47:43 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36573/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:47:43 INFO - PID 18866 | RSS: Main: 149565440 04:47:43 INFO - PID 18866 | 04:47:46 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36573/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:47:46 INFO - PID 18866 | RSS: Main: 149536768 04:47:46 INFO - PID 18866 | 04:47:49 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36573/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:50 INFO - PID 18866 | RSS: Main: 149725184 04:47:50 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | Cycle 1(1): loaded http://localhost:36573/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36573/tests/kraken/driver.html?testName=ai-astar) 04:47:51 INFO - PID 18866 | RSS: Main: 151429120 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | __start_tp_report 04:47:51 INFO - PID 18866 | _x_x_mozilla_page_load 04:47:51 INFO - PID 18866 | _x_x_mozilla_page_load_details 04:47:51 INFO - PID 18866 | |i|pagename|runs| 04:47:51 INFO - PID 18866 | |0;ai-astar;104;105;105;105;105;107;106;105;105;106 04:47:51 INFO - PID 18866 | |1;audio-beat-detection;113;112;117;110;111;118;112;111;117;117 04:47:51 INFO - PID 18866 | |2;audio-dft;164;165;164;163;162;163;163;163;163;163 04:47:51 INFO - PID 18866 | |3;audio-fft;73;72;77;73;73;73;74;73;73;73 04:47:51 INFO - PID 18866 | |4;audio-oscillator;79;77;77;78;77;79;77;79;77;78 04:47:51 INFO - PID 18866 | |5;imaging-gaussian-blur;114;114;113;114;114;115;115;111;114;117 04:47:51 INFO - PID 18866 | |6;imaging-darkroom;148;150;148;149;149;147;149;149;148;149 04:47:51 INFO - PID 18866 | |7;imaging-desaturate;94;93;99;94;93;93;94;99;94;99 04:47:51 INFO - PID 18866 | |8;json-parse-financial;47;47;43;44;43;44;44;45;42;43 04:47:51 INFO - PID 18866 | |9;json-stringify-tinderbox;39;38;38;38;39;39;39;38;39;38 04:47:51 INFO - PID 18866 | |10;stanford-crypto-aes;71;70;69;71;70;72;71;71;70;69 04:47:51 INFO - PID 18866 | |11;stanford-crypto-ccm;103;107;103;105;107;109;100;111;101;104 04:47:51 INFO - PID 18866 | |12;stanford-crypto-pbkdf2;159;152;151;159;147;152;152;147;146;151 04:47:51 INFO - PID 18866 | |13;stanford-crypto-sha256-iterative;59;59;58;59;62;58;62;59;62;58 04:47:51 INFO - PID 18866 | __end_tp_report 04:47:51 INFO - PID 18866 | __start_cc_report 04:47:51 INFO - PID 18866 | _x_x_mozilla_cycle_collect,687 04:47:51 INFO - PID 18866 | __end_cc_report 04:47:51 INFO - PID 18866 | __startTimestamp1507722471930__endTimestamp 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | ------- Summary: start ------- 04:47:51 INFO - PID 18866 | Number of tests: 14 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#0] ai-astar Cycles:10 Average:105.30 Median:105.00 stddev:0.82 (0.8%) stddev-sans-first:0.73 04:47:51 INFO - PID 18866 | Values: 104.0 105.0 105.0 105.0 105.0 107.0 106.0 105.0 105.0 106.0 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#1] audio-beat-detection Cycles:10 Average:113.80 Median:115.00 stddev:3.08 (2.7%) stddev-sans-first:3.26 04:47:51 INFO - PID 18866 | Values: 113.0 112.0 117.0 110.0 111.0 118.0 112.0 111.0 117.0 117.0 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 04:47:51 INFO - PID 18866 | Values: 164.0 165.0 164.0 163.0 162.0 163.0 163.0 163.0 163.0 163.0 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#3] audio-fft Cycles:10 Average:73.40 Median:73.00 stddev:1.35 (1.8%) stddev-sans-first:1.42 04:47:51 INFO - PID 18866 | Values: 73.0 72.0 77.0 73.0 73.0 73.0 74.0 73.0 73.0 73.0 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.00 stddev:0.92 (1.2%) stddev-sans-first:0.87 04:47:51 INFO - PID 18866 | Values: 79.0 77.0 77.0 78.0 77.0 79.0 77.0 79.0 77.0 78.0 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 04:47:51 INFO - PID 18866 | Values: 114.0 114.0 113.0 114.0 114.0 115.0 115.0 111.0 114.0 117.0 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 04:47:51 INFO - PID 18866 | Values: 148.0 150.0 148.0 149.0 149.0 147.0 149.0 149.0 148.0 149.0 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.00 stddev:2.66 (2.8%) stddev-sans-first:2.78 04:47:51 INFO - PID 18866 | Values: 94.0 93.0 99.0 94.0 93.0 93.0 94.0 99.0 94.0 99.0 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#8] json-parse-financial Cycles:10 Average:44.20 Median:44.00 stddev:1.69 (3.8%) stddev-sans-first:1.45 04:47:51 INFO - PID 18866 | Values: 47.0 47.0 43.0 44.0 43.0 44.0 44.0 45.0 42.0 43.0 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#9] json-stringify-tinderbox Cycles:10 Average:38.50 Median:39.00 stddev:0.53 (1.4%) stddev-sans-first:0.53 04:47:51 INFO - PID 18866 | Values: 39.0 38.0 38.0 38.0 39.0 39.0 39.0 38.0 39.0 38.0 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#10] stanford-crypto-aes Cycles:10 Average:70.40 Median:71.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 04:47:51 INFO - PID 18866 | Values: 71.0 70.0 69.0 71.0 70.0 72.0 71.0 71.0 70.0 69.0 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#11] stanford-crypto-ccm Cycles:10 Average:105.00 Median:106.00 stddev:3.50 (3.3%) stddev-sans-first:3.63 04:47:51 INFO - PID 18866 | Values: 103.0 107.0 103.0 105.0 107.0 109.0 100.0 111.0 101.0 104.0 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.60 Median:152.00 stddev:4.53 (3.0%) stddev-sans-first:3.93 04:47:51 INFO - PID 18866 | Values: 159.0 152.0 151.0 159.0 147.0 152.0 152.0 147.0 146.0 151.0 04:47:51 INFO - PID 18866 | 04:47:51 INFO - PID 18866 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.60 Median:59.00 stddev:1.71 (2.9%) stddev-sans-first:1.80 04:47:51 INFO - PID 18866 | Values: 59.0 59.0 58.0 59.0 62.0 58.0 62.0 59.0 62.0 58.0 04:47:51 INFO - PID 18866 | -------- Summary: end -------- 04:47:51 INFO - PID 18866 | 04:47:52 INFO - PID 18866 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:47:52 INFO - TEST-INFO | 18866: exit 0 04:47:52 INFO - TEST-OK | kraken | took 58344ms 04:47:52 INFO - SUITE-END | took 1165s 04:47:52 INFO - Completed test suite (00:19:25) 04:47:52 INFO - javascript benchmark 04:47:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9394.815003786813, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3981.0644498542847, 4002.119533702586, 4008.7193896427225, 4014.839406423745, 4023.476947996759, 6465.191851018622, 6562.47500199984, 6623.370779775925, 6626.8674626507445, 6658.467322614191, 6566.606003639785, 6582.802515924518, 6595.53831231814, 6660.067590537316, 6669.43309818666, 5834.095715164135, 5927.673977931212, 5939.703014849262, 5943.346231914507, 5966.075258334943, 5946.435088666592, 5966.46301832835, 5971.4625683688455, 5974.163617093589, 6078.939210607904, 5981.49157321626, 6053.606515576495, 6066.545009124334, 6073.7874174403905, 6084.148219249309, 5922.822315330547, 5946.345901950782, 5975.820725378246, 5992.250968628921, 6076.2404699412355, 5772.336181339116, 5775.768969241225, 5848.590598658096, 5850.180974663551, 5944.554158438091, 6429.646369449679, 6509.414152726277, 6521.706523206467, 6532.771353002622, 6567.211934567835, 7101.2898710128575, 7102.39629631482, 7112.253213412569, 7202.099737532809, 7214.747483838093, 7089.610071446068, 7126.287371262884, 7204.711811527585, 7224.096987876515, 7226.132864056294, 6623.4701223901975, 6768.052472653832, 6770.69531871067, 6786.117804685359, 6787.321267873173, 7366.558006519626, 7399.926000740032, 7403.703851845974, 7409.110906691231, 7486.775396738107, 6970.546914450544, 7026.156861176692, 7054.012438258648, 7077.716891324392, 7192.784216473514, 7117.181524124689, 7118.430525557943, 7119.252478489788, 7120.145582530026, 7154.642267886585, 6936.098307220029, 7121.9643901780155, 7124.46566507514, 7185.89221161683, 7217.386522145572, 7017.228104908456, 7050.330218629325, 7103.218645948941, 7134.215236324, 7139.178994415604, 5176.767045482962, 5215.6609820361555, 5255.0540902637895, 5282.683039017671, 5309.0, 4749.857504274877, 4837.37114175155, 4842.443119041285, 4850.417949846041, 4867.561919427269, 6623.4701223901975, 6626.0, 6629.668516574152, 6696.0, 6722.9663851680425, 7073.363397294268, 7089.751858685025, 7102.112235970504, 7184.6048467334795, 7193.604351760703, 6690.464762818963, 6698.028785826028, 6729.831754206184, 6745.3591908768585, 6751.729930802713, 5986.521078313812, 5992.790252341147, 6058.0610005449225, 6072.726727297282, 6074.787382441594, 7386.372158366492, 7391.260873912565, 7488.513246638951, 7501.812454688677, 7529.849403012018, 7137.072180616487, 7157.856842863218, 7162.928370716435, 7192.352688258082, 7195.568265904062, 7462.44031697614, 7481.513701609378, 7559.395248380007, 7572.053493313336, 7572.39420846342, 6919.377256046779, 6987.965060174666, 7022.6488675565, 7112.324329188718, 7119.359257666835, 7000.859982800417, 7007.264237255014, 7044.189918159477, 7091.397231235403, 7100.964495177491, 6779.050932869303, 6832.760853370109, 6833.965830170818, 6880.621565813928, 6889.0, 6897.48268879826, 6985.720571177096, 7011.964940175267, 7019.2629773873, 7043.0, 6821.147356580427, 6857.0, 6925.89611155823, 6930.06444130036, 6969.02433659278, 6817.7272909083085, 6848.760293389708, 6900.413464855544, 6940.167179938439, 7012.4390048796995, 6742.5280230383405, 6835.179778426422, 6848.212455567674, 6851.2121106071445, 6861.245263020964], "value": 6545.108946902498, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [952.9190018848398, 975.1467465967279, 1009.5507499162876, 1012.6607586458535, 1015.5886865819341, 45966.54033459664, 46502.76748616252, 46613.533864661345, 46657.7667111664, 46807.29789053163, 43520.347194792026, 43543.56456435435, 43686.0, 43940.78029609856, 47837.28244076342, 8734.65061397545, 8846.734597962039, 8891.510966896818, 8893.555322233895, 8900.910990890074, 8321.625526851307, 8383.371247156458, 8392.076871544125, 8403.41176117672, 8405.831883362329, 8391.70629027984, 8405.705800296992, 8436.029856566482, 8457.57712114395, 8471.025832029303, 8326.958365208196, 8335.708250211244, 8374.623141958657, 8396.286315663176, 8411.873821892677, 8668.133186681345, 8669.21977022071, 8678.218960293541, 8679.609417576225, 8735.039145693969, 42645.57354426447, 42903.0, 42960.0, 42993.0, 43046.78476607597, 3630.709543236535, 3637.781733095996, 3655.9086022849374, 3658.652428019334, 3660.3411385950517, 35208.823955880056, 35340.46989295162, 35354.469682954776, 35409.46885796715, 35554.64445355539, 5460.481254280877, 5542.972285138549, 5612.887742245173, 5639.0, 5663.971680141614, 244854.99999999822, 247140.0, 247747.0, 248514.0, 248878.0, 50074.0, 50893.49106508961, 56193.71903140458, 56201.0, 56394.154087688716, 59522.40477595255, 59872.70063649741, 59889.0, 60459.697701512094, 60488.697556512816, 18721.90639046796, 18804.15381307817, 18832.0, 18864.245430182913, 18917.810821891606, 15540.0, 15730.0, 15823.762643560356, 15850.920745396199, 15867.365305387886, 14079.296035198198, 14267.0, 14375.209363485108, 14407.135571865512, 14444.638884027983, 5347.705876176848, 5434.592405569598, 5448.400675925645, 5518.503334699816, 5518.613697041169, 1128.633194211868, 1131.4455916600807, 1132.3319241647469, 1142.4687520303098, 1150.2293463379556, 26092.0, 26552.867235664085, 26819.463610727675, 26923.461530769666, 27324.0, 1230.1081715756184, 1234.4013153620488, 1237.6905773556612, 1245.6014075495755, 1249.138094714644, 13754.65613359674, 13778.379972901244, 14231.43074277038, 14377.496787612383, 14465.566033019026, 296434.0, 298888.0, 305487.0, 305623.0, 310091.0, 63968.0, 64384.0, 64471.032934506016, 64520.0, 64702.67648661727, 1536.078352988198, 1536.247238852954, 1542.9382824686886, 1544.5520798968398, 1564.8435156484488, 30139.397212056076, 30393.0, 30579.388412232074, 30713.0, 30915.845420772752, 43536.78231608822, 43582.56417435785, 43602.56397435985, 43607.56392436162, 43652.345214821165, 250204.0, 251057.0, 251859.0, 252549.0, 252782.0, 36138.8193059033, 36329.45505817362, 36508.81745591255, 36712.0, 37185.0, 46755.29867051929, 48148.5185148144, 48421.27368089411, 48888.2666760006, 48904.75547622239, 34188.82905585456, 34192.48711269383, 34662.30675386528, 35090.649093508735, 35443.0, 34666.0, 34802.651973479944, 34833.12917177091, 34918.47622285617, 35490.8225458871, 42148.367774482795, 42399.788001059795, 42638.57361426346, 43155.78422107869, 43406.78296608497, 33597.66402335945, 34118.31763364768, 34410.0, 34565.65434345725, 34884.82557587196, 25109.246722598353, 25286.367840804127, 25392.365190870376, 25438.491230175663, 25465.49069018572], "value": 19402.74977684934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.3077614623913, 636.9363063693631, 639.7249182851372, 640.5793065032724, 645.6287634610101, 23517.529649407043, 24084.879575602143, 24755.876220618873, 24777.132800351992, 25170.24489265325, 25349.873250633766, 26680.59979100315, 26750.0, 26756.732432675668, 26764.19707408781, 6542.934570654304, 6652.833679158036, 6662.566933149354, 6689.0, 6705.899411508832, 6801.081853949728, 6850.383465488105, 6852.897206541906, 6860.279670634562, 6860.416864566518, 6813.3527314905, 6815.284395138513, 6826.419754320888, 6827.21487028993, 6832.487563432737, 6758.324167583251, 6817.488688348344, 6822.0, 6825.215100263484, 6825.556338837984, 6325.87348253037, 6386.393292637192, 6391.776287829904, 6412.326705695881, 6422.775202867924, 29963.700362996307, 30882.845585772153, 30904.14575125477, 31053.534196987064, 31855.84072079648, 2370.8577485350934, 2416.0094361311776, 2424.5878200705924, 2431.3556907419547, 2441.9145329913545, 20405.693914591295, 20765.377038688865, 21252.89373553138, 21273.36179914605, 21373.465663358384, 2630.592258199982, 2658.5081759874292, 2681.4503026879443, 2687.932801679954, 2701.8784154713085, 138379.0, 141780.0, 160148.0, 165223.0, 165893.17053414776, 15855.688344404523, 16454.75317870233, 16903.083920627683, 16914.577135571464, 17011.319547217972, 27590.862045690046, 27689.446211075665, 27864.024759133332, 27893.72106278952, 27929.720702793118, 11516.424178791027, 11652.0, 11668.066554675606, 11755.471003804849, 11894.88105118955, 10656.733581660521, 10678.62624808128, 10724.78550428987, 10775.515101820436, 10816.67549973502, 9815.901840981642, 9900.702978910644, 9981.950090249502, 10153.340032897986, 10218.948905255425, 2951.4834903891733, 3054.541818727209, 3057.6636569977286, 3106.1302835205724, 3180.6349301337796, 1056.963006294776, 1058.7829494953517, 1069.7967386196597, 1076.0315715855793, 1079.8920107989138, 21095.156193752384, 21781.673274900888, 22034.669479957494, 22069.006894689777, 22070.779292207193, 1117.379854180921, 1126.9492872820742, 1140.3443020263383, 1145.4272863568217, 1153.2849633227452, 11817.172797904064, 11954.701132471759, 12038.337891416057, 12056.397180140957, 12202.816957745641, 649511.0, 667451.0, 671755.0, 684830.0, 686660.0, 129498.0, 129896.0, 131278.34360828134, 132514.33742831225, 134252.0, 1156.6067537037447, 1212.6847019774923, 1213.3933033483258, 1243.9253644781343, 1293.9935300323439, 22203.0, 22676.546469070858, 22851.657225141305, 22919.312420627408, 22958.311250662508, 61155.69422152861, 62466.687666561374, 63134.68432657807, 63288.68355658192, 64427.35572644213, 83707.0, 83834.58082709792, 83901.0, 83961.16038839534, 84922.0, 16231.350745970502, 16502.917485412498, 16509.0, 16538.834611654212, 16553.0, 24726.876365618056, 25092.749072509043, 25174.24477265685, 25242.368940775894, 25271.87364063168, 19927.60144797067, 19932.800671993675, 20222.292219772826, 20242.08910598997, 20323.187072516932, 18271.451856444328, 18291.359802407384, 18631.81368186301, 18669.626607468046, 18686.719699204794, 19890.204391824165, 20070.49823754418, 20377.79622203759, 20382.490437739176, 20701.792982069986, 16253.837461625233, 16293.185340733153, 16338.918305408397, 16371.42700005494, 16381.0, 20020.899895500428, 20172.29396971099, 20216.19135234574, 20239.392818215478, 20525.281615143398], "value": 13285.522240356813, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1484.8069750932377, 1534.3939144038104, 1534.8388419215983, 1538.230884557721, 1545.2428310128034, 17426.215820288086, 18094.0, 18130.456086317397, 18133.909330453364, 18171.273149074055, 17678.292868285287, 17816.554586135353, 17816.64366712665, 17831.910840445813, 17854.553636159104, 3117.6726443723423, 3120.953185702216, 3169.9207519811957, 3170.429322721909, 3182.0771976126894, 3050.816950982948, 3092.3660649566896, 3105.580746599203, 3105.736012438945, 3105.937881242374, 3089.1041597936683, 3095.303556699736, 3198.760092993023, 3207.1180425382972, 3209.7753157279, 3162.0671901788915, 3179.1893067267815, 3188.21888637283, 3191.3138675184946, 3197.1207917822553, 3080.522519009557, 3083.6145481814774, 3084.4447999360104, 3085.6451508076634, 3088.629364476255, 16805.747913781302, 17118.743218851727, 17160.485185444457, 17162.57093572658, 17163.828361716474, 9073.954630226806, 9308.813823723556, 9334.439933604006, 9360.0, 9370.39092458988, 5479.0, 5578.112963745264, 5644.491995720405, 5687.516561092312, 5774.393688662672, 2133.775953524873, 2162.156758864044, 2171.1966572368165, 2221.533477969628, 2223.4774827915426, 32920.176995575064, 32974.6702532974, 33006.17484562905, 33070.0, 33221.16947076318, 7734.4585878989055, 7769.689212431439, 7869.409794265453, 8000.079990801132, 8055.395845311625, 20841.791582083984, 20870.26954056601, 20997.895010525153, 21019.579608407745, 21154.682679759815, 8694.391392602458, 8976.14726600985, 8987.595558199897, 8997.505137217517, 9008.459492430475, 8061.959690201512, 8094.392920530984, 8315.04376996641, 8391.0, 8406.831863362699, 6287.811365659038, 6336.239651241788, 6366.427021568081, 6438.291787903327, 6692.364225398579, 1714.691355555987, 1758.5691505581215, 1867.4584370532666, 1887.603603243307, 1899.069455966594, 899.9055099214619, 908.8046070094962, 912.1471424218245, 919.4483310013939, 920.3281604428804, 8707.869381959275, 8756.56217189138, 8757.430767000125, 8764.255038321686, 8858.335624828163, 1093.9398333091756, 1095.6548687163518, 1100.6697990602788, 1107.545906178463, 1123.8089524780808, 5096.541311282002, 5233.345831771028, 5244.921326180111, 5258.053550360972, 5304.336957880265, 25981.22056338313, 26682.866585666947, 26988.460230795667, 27784.166475005783, 27994.440111197662, 25649.61525577118, 26835.865820670773, 26955.460890782073, 27304.180874573794, 27477.587836182473, 12818.0, 12960.157589756636, 12981.350932453339, 13054.934725326313, 13055.673608159683, 8966.775830604287, 8974.057723938893, 8989.730308090768, 9012.2790176787, 9074.319426043205, 22772.886135569217, 23114.884425577766, 23157.989461369914, 23773.286801395985, 23922.760772392052, 24065.398365040313, 24276.95004382152, 24280.392990175387, 24456.75543244616, 24466.266012019667, 13138.408771605109, 13318.400671969592, 13388.2636454992, 13388.866111338762, 13399.598012059654, 15990.520284391487, 16031.438899638923, 16178.67642647117, 16338.754918676466, 16465.67068658644, 12558.686032848886, 12851.357432128543, 12906.096573240158, 13111.541096061592, 13165.275909824668, 12532.37338133108, 12550.623481295575, 13024.348782560644, 13083.0, 13212.537561185312, 11764.470598823245, 11769.293842369485, 11790.587329443428, 11902.880971190178, 11962.282263064244, 8731.694390696295, 8738.606762695821, 8789.604467799092, 8840.160184782435, 8979.14698103679, 8482.194191551793, 8651.740447786577, 8683.913160868311, 8761.824763504821, 8811.030786613595], "value": 7740.609691289588, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.725734390149, 559.9636023658462, 579.3106203617697, 586.6216290492632, 603.5624172474957, 6303.0, 6330.968345158268, 6385.776497822577, 6437.5493715439825, 6484.837879053026, 6255.562110652256, 6256.812295631127, 6282.497400207983, 6312.495000399968, 6327.46216571592, 5031.0, 5196.428392876781, 5200.297959775429, 5224.6081543884175, 5240.947590524084, 5114.744262786864, 5146.279520867081, 5168.379794424674, 5178.637495375326, 5183.766730497118, 5050.46970068143, 5061.266116413118, 5078.857257117156, 5088.92366614501, 5100.5154510321645, 5100.0, 5126.102931986925, 5154.845354639348, 5167.9224811627855, 5206.349206349207, 4673.719576825401, 4709.481956984729, 4722.197226471474, 4742.336072949755, 4749.192637251641, 6142.8771424571705, 6163.08944227291, 6213.440790328847, 6317.305096439388, 6347.460465860361, 5950.851228719273, 5986.3714309997695, 5996.430339117776, 6014.12795144706, 6027.547933904931, 6759.763408280735, 6766.221884483298, 6813.148356455443, 6835.248122706498, 6881.380675739158, 4911.8772030699165, 5184.481551844785, 5195.220716892496, 5203.0, 5210.895782084375, 6840.657967101674, 6844.0, 6985.965070174617, 7012.859742805166, 7012.896131160632, 5354.571634269249, 5371.785128594891, 5373.973130134403, 5384.892302154013, 5407.648502847381, 5415.512603865593, 5445.0, 5448.964696707613, 5471.206675032098, 5488.533474654699, 6004.42957918997, 6011.579189456696, 6038.969805150946, 6067.514598832171, 6083.574149809471, 6876.421341996751, 6895.586264824126, 6906.102206713095, 6914.619695916773, 6916.896246556305, 1851.3982955539504, 1857.4056301983505, 1865.8973756443527, 1876.9249230030646, 1883.8696781930732, 1295.0999055656416, 1310.8230388897568, 1334.4395353951363, 1351.6080336702444, 1352.3508715816463, 6206.72069756862, 6235.3452887446165, 6248.9062664060075, 6304.621722696561, 6343.682815859189, 6765.560238584575, 6786.423154031864, 6841.17905851301, 6851.554648947803, 6925.887604280642, 6296.0, 6302.306746257908, 6317.368263173646, 6325.683715814283, 6362.872742545123, 3611.4582812578324, 3638.381475149231, 3645.85416583339, 3652.374693261473, 3671.3024525340634, 7133.822919218374, 7138.643067846587, 7194.784156475314, 7216.654587259161, 7281.854362912712, 7101.857962840714, 7110.324519170774, 7123.89314160288, 7153.96423017892, 7156.570605763567, 7216.603086830275, 7225.963870180615, 7283.708651653875, 7293.598852063187, 7301.634918254066, 6825.829354266183, 6949.583025018515, 6956.37392634645, 6965.825854353681, 7005.6146911918295, 6843.828904277433, 6868.278830722902, 6877.552959057845, 6886.827829304308, 6916.51584389108, 7119.1457025157315, 7135.821604459722, 7166.89249661266, 7190.42476601881, 7221.241769614115, 5287.259783630372, 5365.248865158803, 5368.973155134199, 5398.4871437213405, 5417.345500704705, 6644.468442524683, 6660.733570657313, 6823.829404264735, 6862.897056544056, 6971.198312193959, 6608.636524991171, 6616.636085015371, 6647.401733843977, 6677.76627818024, 6732.293109223461, 6554.672266386567, 6556.213254409501, 6664.633445160369, 6679.4656427484715, 6709.228438729609, 6313.779017734358, 6560.507961902781, 6640.667966601554, 6663.800085997428, 6679.265280819203, 6670.933290667225, 6695.296993815579, 6720.428763555153, 6808.0, 6832.0, 6555.344465553407, 6560.8359791005605, 6609.20689517261, 6633.1376920999965, 6653.900191497229], "value": 5308.0062069751975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [946.1201082992818, 964.2286171063148, 964.8552717092435, 976.5898322704463, 978.4667356290821, 20556.0, 21236.25673101438, 21273.36179914605, 21367.35897923061, 21453.249136280232, 20052.298169564066, 20263.898680506612, 20398.490037749063, 20435.897820510912, 20439.386818395436, 1036.4506811389938, 1071.8124328242566, 1073.6349641122017, 1073.9624113156042, 1075.3225467955178, 1091.939943303118, 1092.6776600902713, 1092.721356054209, 1097.462243500683, 1102.9852535667205, 1107.9169062320318, 1150.844635974141, 1151.130896173392, 1153.2388623508486, 1154.4689442856254, 1147.2428197389725, 1150.223599070624, 1151.6372342712061, 1152.130141742987, 1153.8730739618636, 816.1756625807917, 819.7540737778643, 819.8524265632184, 823.5882058970515, 829.8215883584998, 21520.139194432202, 21882.89058554713, 22273.44316392087, 22292.66561001586, 22551.436214094614, 23449.76550234493, 23517.529649407086, 23572.882135589385, 23989.880050599637, 24214.273571792874, 17177.141142942804, 17384.043877586853, 17482.912585436992, 17557.0, 17560.209790559456, 4127.587241275878, 4210.789460526961, 4230.132822771356, 4237.364395340693, 4237.915241695179, 129816.0, 145794.27102864525, 161510.0, 165236.17381913133, 167360.16319918443, 18070.638587228445, 18542.907285463756, 18578.814211857978, 18631.0, 18861.245550178115, 34749.82625086858, 34813.65186348155, 34968.82515587406, 35229.47155792665, 35316.0, 10680.89319106799, 10708.19688523364, 10709.571617135383, 10742.355458672348, 10744.785104297871, 4814.735189564608, 4827.0, 4837.588804951619, 4886.413630364379, 4910.48439913811, 6154.0, 6336.619802811846, 6338.70056638388, 6358.904616430757, 6362.77730279438, 1226.9018478521875, 1251.9123661343801, 1272.6500212441654, 1281.1352337172557, 1285.9035572332114, 654.5156584127711, 657.5035847934779, 674.0866126398757, 678.9558678685969, 691.3915754136328, 12143.453544590515, 12435.440405181607, 12653.557125500563, 12831.935840320739, 13489.865101349058, 696.9407600354027, 713.9464540159405, 718.9748358807417, 726.6512074204411, 734.346431675809, 5542.445755424425, 5606.747696353674, 5636.154576813511, 5637.746301416446, 5704.857378565569, 144486.0, 146956.0, 148745.0, 149560.0, 150754.24622877035, 134811.0, 135631.32184339015, 137770.0, 137816.31091844477, 140111.0, 119461.0, 121154.67084201911, 121730.0, 122175.38912305381, 123464.0, 10758.40828754426, 10802.351858888493, 10917.0, 10920.78158436811, 10994.780104398027, 56307.71846140743, 56543.43456565381, 56583.0, 57108.42891571031, 58378.7081064592, 71458.0, 71963.64018179875, 72301.27698722946, 73445.26554734384, 75126.0, 17000.0, 17115.315387384366, 17135.57161070983, 17143.314267429163, 17192.570185745455, 18217.180226890086, 18530.722039169694, 18586.349477768214, 18711.1579978904, 19034.7144792831, 16995.830041699424, 17170.22733976949, 17267.0, 17440.47678569645, 17571.0, 15649.1392973383, 16040.518784436486, 16046.679066418374, 16058.116803575915, 16087.919560402122, 16655.833441665913, 17004.914975425043, 17046.403375881786, 17093.658126837643, 17214.569635759206, 11802.704932376759, 12278.754424911273, 12400.19398739079, 12423.0, 12551.497940082294, 12320.507179712711, 12428.937855310665, 12437.564685235973, 12485.687857803627, 12535.749285014066], "value": 9918.322844953133, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1360.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 105.0, 105.0, 105.0, 105.0, 107.0, 106.0, 105.0, 105.0, 106.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 117.0, 110.0, 111.0, 118.0, 112.0, 111.0, 117.0, 117.0], "value": 113.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 163.0, 162.0, 163.0, 163.0, 163.0, 163.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 77.0, 73.0, 73.0, 73.0, 74.0, 73.0, 73.0, 73.0], "value": 73.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 77.0, 78.0, 77.0, 79.0, 77.0, 79.0, 77.0, 78.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 115.0, 115.0, 111.0, 114.0, 117.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 148.0, 149.0, 149.0, 147.0, 149.0, 149.0, 148.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 99.0, 94.0, 93.0, 93.0, 94.0, 99.0, 94.0, 99.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 43.0, 44.0, 43.0, 44.0, 44.0, 45.0, 42.0, 43.0], "value": 44.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 38.0, 38.0, 38.0, 39.0, 39.0, 39.0, 38.0, 39.0, 38.0], "value": 38.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 69.0, 71.0, 70.0, 72.0, 71.0, 71.0, 70.0, 69.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 107.0, 103.0, 105.0, 107.0, 109.0, 100.0, 111.0, 101.0, 104.0], "value": 105.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 152.0, 151.0, 159.0, 147.0, 152.0, 152.0, 147.0, 146.0, 151.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 62.0, 58.0, 62.0, 59.0, 62.0, 58.0], "value": 59.6, "unit": "score"}]}]} 04:47:52 INFO - Return code: 0 04:47:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:47:52 INFO - # TBPL SUCCESS # 04:47:52 INFO - Running post-action listener: _package_coverage_data 04:47:52 INFO - Running post-action listener: _resource_record_post_action 04:47:52 INFO - [mozharness: 2017-10-11 11:47:52.751895Z] Finished run-tests step (success) 04:47:52 INFO - Running post-run listener: _resource_record_post_run 04:47:52 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 284397568; Read time: 224; Write time: 132824 04:47:52 INFO - TinderboxPrint: CPU usage
13.0% 04:47:52 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 224 04:47:52 INFO - TinderboxPrint: I/O write bytes / time
284,397,568 / 132,824 04:47:52 INFO - TinderboxPrint: CPU idle
8,181.5 (87.0%) 04:47:52 INFO - TinderboxPrint: CPU user
1,177.8 (12.5%) 04:47:52 INFO - TinderboxPrint: Swap in / out
0 / 0 04:47:52 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9789440; Read time: 0; Write time: 1176 04:47:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:47:52 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 8192; Write bytes: 274608128; Read time: 224; Write time: 131648 04:47:53 INFO - Running post-run listener: _upload_blobber_files 04:47:53 INFO - Blob upload gear active. 04:47:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:47:53 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 04:47:53 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'] 04:47:53 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 04:47:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:47:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:47:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:47:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:54 INFO - (blobuploader) - INFO - Done attempting. 04:47:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:47:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:48:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:01 INFO - (blobuploader) - INFO - Done attempting. 04:48:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:48:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:48:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:02 INFO - (blobuploader) - INFO - Done attempting. 04:48:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:48:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:48:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:48:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:03 INFO - (blobuploader) - INFO - Done attempting. 04:48:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:48:03 INFO - Return code: 0 04:48:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:48:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:48:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/df0b5a0ffc7c45f538f84b1c5377b9496e13a4d441513c1f763a0c332a756fd63669e1d2bab21bc58d74d3ec6b8f9304ba12ae5b34180d06237e26810efcecb5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5924f63fa248e716750b49a5ae4354da1b8e3adaf6db2700a9212c901df6c7a7c201d5fcdb196de738a3d3d65a5a164a40cbb82bed88b56cdb6403ffb85ad1ac", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9b806dde27ea2f0faf35002eea365abc555a69096d74e52c130580b72058698fd943b3c9e08a639c6e3658efd6a21e511ed1ea413bade4fd93c8c3170a0354cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cc83a827da6ea3456a0bd44930f2f6094c021b3da0b47c1d6eea86a4bd5e02e926a2a70694d21918728a820cda2f65e08b639edf54ee859298c0ab26938d7d44"} 04:48:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:48:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:48:03 INFO - Contents: 04:48:03 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/df0b5a0ffc7c45f538f84b1c5377b9496e13a4d441513c1f763a0c332a756fd63669e1d2bab21bc58d74d3ec6b8f9304ba12ae5b34180d06237e26810efcecb5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5924f63fa248e716750b49a5ae4354da1b8e3adaf6db2700a9212c901df6c7a7c201d5fcdb196de738a3d3d65a5a164a40cbb82bed88b56cdb6403ffb85ad1ac", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9b806dde27ea2f0faf35002eea365abc555a69096d74e52c130580b72058698fd943b3c9e08a639c6e3658efd6a21e511ed1ea413bade4fd93c8c3170a0354cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cc83a827da6ea3456a0bd44930f2f6094c021b3da0b47c1d6eea86a4bd5e02e926a2a70694d21918728a820cda2f65e08b639edf54ee859298c0ab26938d7d44"} 04:48:03 INFO - Running post-run listener: copy_logs_to_upload_dir 04:48:03 INFO - Copying logs to upload dir... 04:48:03 INFO - mkdir: /builds/slave/test/build/upload/logs 04:48:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.604012 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-10-11 04:48:03.770840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-11 04:48:03.775864) ========= 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=0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/df0b5a0ffc7c45f538f84b1c5377b9496e13a4d441513c1f763a0c332a756fd63669e1d2bab21bc58d74d3ec6b8f9304ba12ae5b34180d06237e26810efcecb5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5924f63fa248e716750b49a5ae4354da1b8e3adaf6db2700a9212c901df6c7a7c201d5fcdb196de738a3d3d65a5a164a40cbb82bed88b56cdb6403ffb85ad1ac", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9b806dde27ea2f0faf35002eea365abc555a69096d74e52c130580b72058698fd943b3c9e08a639c6e3658efd6a21e511ed1ea413bade4fd93c8c3170a0354cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cc83a827da6ea3456a0bd44930f2f6094c021b3da0b47c1d6eea86a4bd5e02e926a2a70694d21918728a820cda2f65e08b639edf54ee859298c0ab26938d7d44"} build_url:https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011568 build_url: 'https://queue.taskcluster.net/v1/task/AgFmK7ikTrmnDqFk5RVXjA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/df0b5a0ffc7c45f538f84b1c5377b9496e13a4d441513c1f763a0c332a756fd63669e1d2bab21bc58d74d3ec6b8f9304ba12ae5b34180d06237e26810efcecb5", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5924f63fa248e716750b49a5ae4354da1b8e3adaf6db2700a9212c901df6c7a7c201d5fcdb196de738a3d3d65a5a164a40cbb82bed88b56cdb6403ffb85ad1ac", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/9b806dde27ea2f0faf35002eea365abc555a69096d74e52c130580b72058698fd943b3c9e08a639c6e3658efd6a21e511ed1ea413bade4fd93c8c3170a0354cb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/cc83a827da6ea3456a0bd44930f2f6094c021b3da0b47c1d6eea86a4bd5e02e926a2a70694d21918728a820cda2f65e08b639edf54ee859298c0ab26938d7d44"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-11 04:48:03.808048) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 04:48:03.808359) ========= 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=0e2a256762fed810e2f0f810000001b3-1507721250.462349-1439801105 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004526 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-11 04:48:03.892592) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-11 04:48:03.892909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-11 04:48:03.893224) ========= ========= Total master_lag: 0.28 =========