builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-057 starttime: 1505212163.2 results: success (0) revision: b0e945eed81db8bf076daf64e381c514f70144f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:23.202217) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:23.202636) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:23.202927) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:23.289848) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:23.290197) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-12 03:29:23-- 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% 37.1M=0s 2017-09-12 03:29:23 (37.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134685 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:23.442089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:23.445437) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018789 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:23.506302) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:23.506727) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b0e945eed81db8bf076daf64e381c514f70144f0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev b0e945eed81db8bf076daf64e381c514f70144f0 --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=934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-12 03:29:23,561 truncating revision to first 12 chars 2017-09-12 03:29:23,561 Setting DEBUG logging. 2017-09-12 03:29:23,561 attempt 1/10 2017-09-12 03:29:23,561 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b0e945eed81d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-12 03:29:24,208 unpacking tar archive at: mozilla-central-b0e945eed81d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.917384 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:24.446588) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:24.447106) ========= script_repo_revision: b0e945eed81db8bf076daf64e381c514f70144f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:24.447795) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:24.448246) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-12 03:29:24.463506) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-12 03:29:24.463996) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:29:24 INFO - MultiFileLogger online at 20170912 03:29:24 in /builds/slave/test 03:29:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:29:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:29:24 INFO - {'append_to_log': False, 03:29:24 INFO - 'base_work_dir': '/builds/slave/test', 03:29:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:29:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:29:24 INFO - 'branch': 'Firefox-Non-PGO', 03:29:24 INFO - 'buildbot_json_path': 'buildprops.json', 03:29:24 INFO - 'code_coverage': False, 03:29:24 INFO - 'config_files': ('talos/linux_config.py',), 03:29:24 INFO - 'default_actions': ('clobber', 03:29:24 INFO - 'read-buildbot-config', 03:29:24 INFO - 'download-and-extract', 03:29:24 INFO - 'populate-webroot', 03:29:24 INFO - 'create-virtualenv', 03:29:24 INFO - 'install', 03:29:24 INFO - 'setup-mitmproxy', 03:29:24 INFO - 'run-tests'), 03:29:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:29:24 INFO - 'disable_ccov_upload': False, 03:29:24 INFO - 'disable_stylo': False, 03:29:24 INFO - 'download_minidump_stackwalk': True, 03:29:24 INFO - 'download_symbols': 'ondemand', 03:29:24 INFO - 'enable_stylo': False, 03:29:24 INFO - 'enable_webrender': False, 03:29:24 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:29:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:29:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:29:24 INFO - 'gecko_profile': False, 03:29:24 INFO - 'gecko_profile_interval': 0, 03:29:24 INFO - 'installer_path': 'installer.exe', 03:29:24 INFO - 'log_level': 'info', 03:29:24 INFO - 'log_name': 'talos', 03:29:24 INFO - 'log_to_console': True, 03:29:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:29:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:29:24 INFO - 'opt_config_files': (), 03:29:24 INFO - 'pip_index': False, 03:29:24 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:29:24 INFO - 'system_bits': '32', 03:29:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:29:24 INFO - 'title': 'talos-linux64-ix-057', 03:29:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:29:24 INFO - 'use_talos_json': True, 03:29:24 INFO - 'verify': 'False', 03:29:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:29:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:29:24 INFO - 'work_dir': 'build'} 03:29:24 INFO - [mozharness: 2017-09-12 10:29:24.665876Z] Running clobber step. 03:29:24 INFO - Running pre-action listener: _resource_record_pre_action 03:29:24 INFO - Running main action method: clobber 03:29:24 INFO - rmtree: /builds/slave/test/build 03:29:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:29:26 INFO - Running post-action listener: _resource_record_post_action 03:29:26 INFO - [mozharness: 2017-09-12 10:29:26.193891Z] Finished clobber step (success) 03:29:26 INFO - [mozharness: 2017-09-12 10:29:26.193987Z] Running read-buildbot-config step. 03:29:26 INFO - Running pre-action listener: _resource_record_pre_action 03:29:26 INFO - Running main action method: read_buildbot_config 03:29:26 INFO - Using buildbot properties: 03:29:26 INFO - { 03:29:26 INFO - "project": "", 03:29:26 INFO - "product": "firefox", 03:29:26 INFO - "who": "archaeopteryx@coole-files.de", 03:29:26 INFO - "installer_path": "public/build/target.tar.bz2", 03:29:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:29:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:29:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 03:29:26 INFO - "stage_platform": "linux64", 03:29:26 INFO - "basedir": "/builds/slave/test", 03:29:26 INFO - "buildnumber": 13, 03:29:26 INFO - "platform": "ubuntu64_hw", 03:29:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:29:26 INFO - "slavebuilddir": "test", 03:29:26 INFO - "taskId": "IL6apyA_TAC3-GvOWEiW3w", 03:29:26 INFO - "branch": "mozilla-central", 03:29:26 INFO - "script_repo_revision": "production", 03:29:26 INFO - "revision": "b0e945eed81db8bf076daf64e381c514f70144f0", 03:29:26 INFO - "slavename": "talos-linux64-ix-057", 03:29:26 INFO - "repo_path": "mozilla-central" 03:29:26 INFO - } 03:29:26 INFO - Finding installer, test and symbols from parent task. 03:29:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IL6apyA_TAC3-GvOWEiW3w'}, attempt #1 03:29:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IL6apyA_TAC3-GvOWEiW3w'}, attempt #1 03:29:27 INFO - Task dependencies: Z7UnFtVmTZqJN21MF8D_IQ 03:29:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ'}, attempt #1 03:29:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.tar.bz2 03:29:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.test_packages.json 03:29:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.crashreporter-symbols.zip 03:29:27 INFO - Running post-action listener: _resource_record_post_action 03:29:27 INFO - [mozharness: 2017-09-12 10:29:27.527374Z] Finished read-buildbot-config step (success) 03:29:27 INFO - [mozharness: 2017-09-12 10:29:27.527747Z] Running download-and-extract step. 03:29:27 INFO - Running pre-action listener: _resource_record_pre_action 03:29:27 INFO - Running main action method: download_and_extract 03:29:27 INFO - mkdir: /builds/slave/test/build/tests 03:29:27 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')]} 03:29:27 INFO - trying https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.test_packages.json 03:29:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:29:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:29:28 INFO - Downloaded 989 bytes. 03:29:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:29:28 INFO - Using the following test package requirements: 03:29:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:29:28 INFO - u'common': [u'target.common.tests.zip'], 03:29:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:29:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:29:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:29:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:29:28 INFO - u'mozbase': [u'target.common.tests.zip'], 03:29:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:29:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:29:28 INFO - u'web-platform': [u'target.common.tests.zip', 03:29:28 INFO - u'target.web-platform.tests.tar.gz'], 03:29:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:29:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:29:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.common.tests.zip 03:29:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:29:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.common.tests.zip into memory 03:29:29 INFO - Content-Length response header: 55043940 03:29:29 INFO - Bytes received: 55043940 03:29:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.talos.tests.zip 03:29:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:29:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.talos.tests.zip into memory 03:29:40 INFO - Content-Length response header: 14499231 03:29:40 INFO - Bytes received: 14499231 03:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:41 INFO - trying https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.tar.bz2 03:29:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:29:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:29:42 INFO - Downloaded 62978229 bytes. 03:29:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.tar.bz2 03:29:42 INFO - mkdir: /builds/slave/test/properties 03:29:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:29:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:29:42 INFO - Contents: 03:29:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.tar.bz2 03:29:42 INFO - Running post-action listener: _resource_record_post_action 03:29:42 INFO - Running post-action listener: find_tests_for_verification 03:29:42 INFO - Running post-action listener: set_extra_try_arguments 03:29:42 INFO - [mozharness: 2017-09-12 10:29:42.329687Z] Finished download-and-extract step (success) 03:29:42 INFO - [mozharness: 2017-09-12 10:29:42.329794Z] Running populate-webroot step. 03:29:42 INFO - Running pre-action listener: _resource_record_pre_action 03:29:42 INFO - Running main action method: populate_webroot 03:29:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:29:42 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:42 INFO - 'tests': ['tresize', 03:29:42 INFO - 'tcanvasmark']}, 03:29:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:29:42 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:42 INFO - 'tests': ['dromaeo_css', 03:29:42 INFO - 'kraken']}, 03:29:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:29:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:42 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:29:42 INFO - 'talos_options': ['--disable-stylo'], 03:29:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:29:42 INFO - 'tests': ['damp', 'tps']}, 03:29:42 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:29:42 INFO - 'talos_options': ['--disable-stylo'], 03:29:42 INFO - 'tests': ['damp', 'tps']}, 03:29:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:42 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:42 INFO - 'tests': ['dromaeo_dom']}, 03:29:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:29:42 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:42 INFO - 'tests': ['basic_compositor_video', 03:29:42 INFO - 'glvideo']}, 03:29:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:29:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:29:42 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:29:42 INFO - 'talos_options': ['--disable-stylo'], 03:29:42 INFO - 'tests': ['ts_paint_webext', 03:29:42 INFO - 'tp5o_webext']}, 03:29:42 INFO - 'other-e10s': {'tests': ['a11yr', 03:29:42 INFO - 'ts_paint', 03:29:42 INFO - 'tpaint', 03:29:42 INFO - 'sessionrestore', 03:29:42 INFO - 'sessionrestore_many_windows', 03:29:42 INFO - 'sessionrestore_no_auto_restore', 03:29:42 INFO - 'tabpaint']}, 03:29:42 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:42 INFO - 'tests': ['a11yr', 03:29:42 INFO - 'ts_paint', 03:29:42 INFO - 'tpaint', 03:29:42 INFO - 'sessionrestore', 03:29:42 INFO - 'sessionrestore_many_windows', 03:29:42 INFO - 'sessionrestore_no_auto_restore', 03:29:42 INFO - 'tabpaint']}, 03:29:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:29:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:29:42 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:42 INFO - 'tests': ['bloom_basic_singleton']}, 03:29:42 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:42 INFO - 'tests': ['bloom_basic']}, 03:29:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:29:42 INFO - 'tsvgr_opacity', 03:29:42 INFO - 'tart', 03:29:42 INFO - 'tscrollx', 03:29:42 INFO - 'tsvg_static']}, 03:29:42 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:29:42 INFO - 'tests': ['tsvgx', 03:29:42 INFO - 'tsvgr_opacity', 03:29:42 INFO - 'tart', 03:29:42 INFO - 'tscrollx', 03:29:42 INFO - 'tsvg_static']}, 03:29:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:29:42 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:29:42 INFO - 'talos_options': ['--disable-stylo'], 03:29:42 INFO - 'tests': ['tp5o']}, 03:29:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:42 INFO - 'talos_options': ['--mitmproxy', 03:29:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:42 INFO - '--firstNonBlankPaint'], 03:29:42 INFO - 'tests': ['tp6_google', 03:29:42 INFO - 'tp6_youtube', 03:29:42 INFO - 'tp6_amazon', 03:29:42 INFO - 'tp6_facebook']}, 03:29:42 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:42 INFO - 'talos_options': ['--disable-stylo', 03:29:42 INFO - '--mitmproxy', 03:29:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:42 INFO - '--firstNonBlankPaint'], 03:29:42 INFO - 'tests': ['tp6_google', 03:29:42 INFO - 'tp6_youtube', 03:29:42 INFO - 'tp6_amazon', 03:29:42 INFO - 'tp6_facebook']}, 03:29:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:42 INFO - 'talos_options': ['--stylo-threads=1', 03:29:42 INFO - '--mitmproxy', 03:29:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:42 INFO - '--firstNonBlankPaint'], 03:29:42 INFO - 'tests': ['tp6_google', 03:29:42 INFO - 'tp6_youtube', 03:29:42 INFO - 'tp6_amazon', 03:29:42 INFO - 'tp6_facebook']}, 03:29:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:29:42 INFO - 'talos_options': ['--xperf_path', 03:29:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:42 INFO - 'tests': ['tp5n']}, 03:29:42 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:29:42 INFO - 'talos_options': ['--disable-stylo', 03:29:42 INFO - '--xperf_path', 03:29:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:42 INFO - 'tests': ['tp5n']}}} 03:29:42 INFO - Running post-action listener: _resource_record_post_action 03:29:42 INFO - [mozharness: 2017-09-12 10:29:42.346332Z] Finished populate-webroot step (success) 03:29:42 INFO - [mozharness: 2017-09-12 10:29:42.346437Z] Running create-virtualenv step. 03:29:42 INFO - Running pre-action listener: _resource_record_pre_action 03:29:42 INFO - Running main action method: create_virtualenv 03:29:42 INFO - Creating virtualenv /builds/slave/test/build/venv 03:29:42 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:29:42 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:29:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:29:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:29:42 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:43 INFO - Installing pip...............done. 03:29:43 INFO - Return code: 0 03:29:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:29:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:29:43 INFO - Reading from file tmpfile_stdout 03:29:43 INFO - Output received: 03:29:43 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:29:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:43 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 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef090>, '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 0x2befd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', '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 03:29:43 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 03:29:43 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 03:29:43 INFO - Using env: {'DISPLAY': ':0', 03:29:43 INFO - 'HOME': '/home/cltbld', 03:29:43 INFO - 'LANG': 'en_US.UTF-8', 03:29:43 INFO - 'LANGUAGE': 'en_US:en', 03:29:43 INFO - 'LOGNAME': 'cltbld', 03:29:43 INFO - 'MAIL': '/var/mail/cltbld', 03:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:43 INFO - 'MOZ_NO_REMOTE': '1', 03:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:43 INFO - 'NO_EM_RESTART': '1', 03:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:43 INFO - 'PWD': '/builds/slave/test', 03:29:43 INFO - 'SHELL': '/bin/bash', 03:29:43 INFO - 'SHLVL': '1', 03:29:43 INFO - 'TERM': 'linux', 03:29:43 INFO - 'TMOUT': '86400', 03:29:43 INFO - 'USER': 'cltbld', 03:29:43 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', 03:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:43 INFO - '_': '/tools/buildbot/bin/python'} 03:29:44 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:29:44 INFO - Downloading/unpacking pip>=1.5 03:29:44 INFO - Running setup.py egg_info for package pip 03:29:44 INFO - warning: no files found matching 'pip/cacert.pem' 03:29:44 INFO - warning: no files found matching '*.html' under directory 'docs' 03:29:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:29:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:29:44 INFO - Installing collected packages: pip 03:29:44 INFO - Found existing installation: pip 1.1 03:29:44 INFO - Uninstalling pip: 03:29:44 INFO - Successfully uninstalled pip 03:29:44 INFO - Running setup.py install for pip 03:29:44 INFO - warning: no files found matching 'pip/cacert.pem' 03:29:44 INFO - warning: no files found matching '*.html' under directory 'docs' 03:29:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:29:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:29:44 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:29:44 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:29:44 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:29:44 INFO - Successfully installed pip 03:29:44 INFO - Cleaning up... 03:29:44 INFO - Return code: 0 03:29:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:29:44 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')]} 03:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:44 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')]} 03:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:44 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 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef090>, '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 0x2befd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', '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 03:29:44 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 03:29:44 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 03:29:44 INFO - Using env: {'DISPLAY': ':0', 03:29:44 INFO - 'HOME': '/home/cltbld', 03:29:44 INFO - 'LANG': 'en_US.UTF-8', 03:29:44 INFO - 'LANGUAGE': 'en_US:en', 03:29:44 INFO - 'LOGNAME': 'cltbld', 03:29:44 INFO - 'MAIL': '/var/mail/cltbld', 03:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:44 INFO - 'MOZ_NO_REMOTE': '1', 03:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:44 INFO - 'NO_EM_RESTART': '1', 03:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:44 INFO - 'PWD': '/builds/slave/test', 03:29:44 INFO - 'SHELL': '/bin/bash', 03:29:44 INFO - 'SHLVL': '1', 03:29:44 INFO - 'TERM': 'linux', 03:29:44 INFO - 'TMOUT': '86400', 03:29:44 INFO - 'USER': 'cltbld', 03:29:44 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', 03:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:44 INFO - '_': '/tools/buildbot/bin/python'} 03:29:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:44 INFO - Downloading/unpacking psutil>=3.1.1 03:29:44 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 03:29:44 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 03:29:44 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 03:29:44 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 03:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:29:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:46 INFO - Installing collected packages: psutil 03:29:46 INFO - Running setup.py install for psutil 03:29:46 INFO - building 'psutil._psutil_linux' extension 03:29:46 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 03:29:46 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 03:29:46 INFO - building 'psutil._psutil_posix' extension 03:29:46 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 03:29:46 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 03:29:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:46 INFO - Successfully installed psutil 03:29:46 INFO - Cleaning up... 03:29:46 INFO - Return code: 0 03:29:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:46 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 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef090>, '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 0x2befd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', '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 03:29:46 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 03:29:46 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 03:29:46 INFO - Using env: {'DISPLAY': ':0', 03:29:46 INFO - 'HOME': '/home/cltbld', 03:29:46 INFO - 'LANG': 'en_US.UTF-8', 03:29:46 INFO - 'LANGUAGE': 'en_US:en', 03:29:46 INFO - 'LOGNAME': 'cltbld', 03:29:46 INFO - 'MAIL': '/var/mail/cltbld', 03:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:46 INFO - 'MOZ_NO_REMOTE': '1', 03:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:46 INFO - 'NO_EM_RESTART': '1', 03:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:46 INFO - 'PWD': '/builds/slave/test', 03:29:46 INFO - 'SHELL': '/bin/bash', 03:29:46 INFO - 'SHLVL': '1', 03:29:46 INFO - 'TERM': 'linux', 03:29:46 INFO - 'TMOUT': '86400', 03:29:46 INFO - 'USER': 'cltbld', 03:29:46 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', 03:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:46 INFO - '_': '/tools/buildbot/bin/python'} 03:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:29:46 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 03:29:46 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 03:29:46 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 03:29:46 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 03:29:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:29:47 INFO - Installing collected packages: mozsystemmonitor 03:29:47 INFO - Running setup.py install for mozsystemmonitor 03:29:48 INFO - Successfully installed mozsystemmonitor 03:29:48 INFO - Cleaning up... 03:29:48 INFO - Return code: 0 03:29:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:29:48 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')]} 03:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:48 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')]} 03:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:48 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 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef090>, '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 0x2befd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', '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 03:29:48 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 03:29:48 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 03:29:48 INFO - Using env: {'DISPLAY': ':0', 03:29:48 INFO - 'HOME': '/home/cltbld', 03:29:48 INFO - 'LANG': 'en_US.UTF-8', 03:29:48 INFO - 'LANGUAGE': 'en_US:en', 03:29:48 INFO - 'LOGNAME': 'cltbld', 03:29:48 INFO - 'MAIL': '/var/mail/cltbld', 03:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:48 INFO - 'MOZ_NO_REMOTE': '1', 03:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:48 INFO - 'NO_EM_RESTART': '1', 03:29:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:48 INFO - 'PWD': '/builds/slave/test', 03:29:48 INFO - 'SHELL': '/bin/bash', 03:29:48 INFO - 'SHLVL': '1', 03:29:48 INFO - 'TERM': 'linux', 03:29:48 INFO - 'TMOUT': '86400', 03:29:48 INFO - 'USER': 'cltbld', 03:29:48 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', 03:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:48 INFO - '_': '/tools/buildbot/bin/python'} 03:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:48 INFO - Downloading/unpacking jsonschema==2.5.1 03:29:48 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 03:29:48 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 03:29:48 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 03:29:48 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 03:29:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:29:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:29:51 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 03:29:51 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 03:29:51 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 03:29:51 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 03:29:51 INFO - Downloading functools32-3.2.3-2.tar.gz 03:29:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:29:51 INFO - warning: no files found matching '*.txt' 03:29:51 INFO - no previously-included directories found matching 'build' 03:29:51 INFO - no previously-included directories found matching 'dist' 03:29:51 INFO - no previously-included directories found matching '.git*' 03:29:51 INFO - Installing collected packages: jsonschema, functools32 03:29:51 INFO - Running setup.py install for functools32 03:29:51 INFO - warning: no files found matching '*.txt' 03:29:51 INFO - no previously-included directories found matching 'build' 03:29:51 INFO - no previously-included directories found matching 'dist' 03:29:51 INFO - no previously-included directories found matching '.git*' 03:29:52 INFO - Successfully installed jsonschema functools32 03:29:52 INFO - Cleaning up... 03:29:52 INFO - Return code: 0 03:29:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29: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', '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 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef090>, '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 0x2befd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', '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 03:29: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:29: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 functools32==3.2.3-2 03:29:52 INFO - Using env: {'DISPLAY': ':0', 03:29:52 INFO - 'HOME': '/home/cltbld', 03:29:52 INFO - 'LANG': 'en_US.UTF-8', 03:29:52 INFO - 'LANGUAGE': 'en_US:en', 03:29:52 INFO - 'LOGNAME': 'cltbld', 03:29:52 INFO - 'MAIL': '/var/mail/cltbld', 03:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:52 INFO - 'MOZ_NO_REMOTE': '1', 03:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:52 INFO - 'NO_EM_RESTART': '1', 03:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:52 INFO - 'PWD': '/builds/slave/test', 03:29:52 INFO - 'SHELL': '/bin/bash', 03:29:52 INFO - 'SHLVL': '1', 03:29:52 INFO - 'TERM': 'linux', 03:29:52 INFO - 'TMOUT': '86400', 03:29:52 INFO - 'USER': 'cltbld', 03:29:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', 03:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:52 INFO - '_': '/tools/buildbot/bin/python'} 03:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:29:52 INFO - Cleaning up... 03:29:52 INFO - Return code: 0 03:29:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29: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', '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 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef090>, '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 0x2befd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', '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 03:29: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:29: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 blobuploader==1.2.4 03:29:52 INFO - Using env: {'DISPLAY': ':0', 03:29:52 INFO - 'HOME': '/home/cltbld', 03:29:52 INFO - 'LANG': 'en_US.UTF-8', 03:29:52 INFO - 'LANGUAGE': 'en_US:en', 03:29:52 INFO - 'LOGNAME': 'cltbld', 03:29:52 INFO - 'MAIL': '/var/mail/cltbld', 03:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:52 INFO - 'MOZ_NO_REMOTE': '1', 03:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:52 INFO - 'NO_EM_RESTART': '1', 03:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:52 INFO - 'PWD': '/builds/slave/test', 03:29:52 INFO - 'SHELL': '/bin/bash', 03:29:52 INFO - 'SHLVL': '1', 03:29:52 INFO - 'TERM': 'linux', 03:29:52 INFO - 'TMOUT': '86400', 03:29:52 INFO - 'USER': 'cltbld', 03:29:52 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', 03:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:52 INFO - '_': '/tools/buildbot/bin/python'} 03:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:52 INFO - Downloading/unpacking blobuploader==1.2.4 03:29: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 03:29: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 03:29: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 03:29: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 03:29:53 INFO - Downloading blobuploader-1.2.4.tar.gz 03:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:29:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:29:53 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 03:29:53 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 03:29:53 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 03:29:53 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 03:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:29:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:29:53 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 03:29:53 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 03:29:53 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 03:29:53 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 03:29:54 INFO - Downloading docopt-0.6.1.tar.gz 03:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:29:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:29:54 INFO - Running setup.py install for blobuploader 03:29:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:29:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:29:54 INFO - Running setup.py install for requests 03:29:54 INFO - Running setup.py install for docopt 03:29:54 INFO - Successfully installed blobuploader requests docopt 03:29:54 INFO - Cleaning up... 03:29:54 INFO - Return code: 0 03:29:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:54 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 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef090>, '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 0x2befd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', '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 03:29:54 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 03:29:54 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 03:29:54 INFO - Using env: {'DISPLAY': ':0', 03:29:54 INFO - 'HOME': '/home/cltbld', 03:29:54 INFO - 'LANG': 'en_US.UTF-8', 03:29:54 INFO - 'LANGUAGE': 'en_US:en', 03:29:54 INFO - 'LOGNAME': 'cltbld', 03:29:54 INFO - 'MAIL': '/var/mail/cltbld', 03:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:54 INFO - 'MOZ_NO_REMOTE': '1', 03:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:54 INFO - 'NO_EM_RESTART': '1', 03:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:54 INFO - 'PWD': '/builds/slave/test', 03:29:54 INFO - 'SHELL': '/bin/bash', 03:29:54 INFO - 'SHLVL': '1', 03:29:54 INFO - 'TERM': 'linux', 03:29:54 INFO - 'TMOUT': '86400', 03:29:54 INFO - 'USER': 'cltbld', 03:29:54 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', 03:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:54 INFO - '_': '/tools/buildbot/bin/python'} 03:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:54 INFO - Running setup.py (path:/tmp/pip-J7CTgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:55 INFO - Running setup.py (path:/tmp/pip-5Zrfnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:55 INFO - Running setup.py (path:/tmp/pip-TREbjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:55 INFO - Running setup.py (path:/tmp/pip-isRSj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:55 INFO - Running setup.py (path:/tmp/pip-uP2zmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:55 INFO - Running setup.py (path:/tmp/pip-dTT9Mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:55 INFO - Running setup.py (path:/tmp/pip-Gk7tjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:55 INFO - Running setup.py (path:/tmp/pip-iHM0NK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:55 INFO - Running setup.py (path:/tmp/pip-LF2abF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:55 INFO - Running setup.py (path:/tmp/pip-Xi0RrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:55 INFO - Running setup.py (path:/tmp/pip-eKTZTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:55 INFO - Running setup.py (path:/tmp/pip-llz0ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:55 INFO - Running setup.py (path:/tmp/pip-vPt5tO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:55 INFO - Running setup.py (path:/tmp/pip-c6tbFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:55 INFO - Running setup.py (path:/tmp/pip-LpOEaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:56 INFO - Running setup.py (path:/tmp/pip-mzzl9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:56 INFO - Running setup.py (path:/tmp/pip-5TI9yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:29:56 INFO - Running setup.py install for manifestparser 03:29:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Running setup.py install for mozcrash 03:29:56 INFO - Running setup.py install for mozdebug 03:29:56 INFO - Running setup.py install for mozdevice 03:29:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Running setup.py install for mozfile 03:29:56 INFO - Running setup.py install for mozhttpd 03:29:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Running setup.py install for mozinfo 03:29:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Running setup.py install for mozInstall 03:29:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:29:56 INFO - Running setup.py install for mozleak 03:29:57 INFO - Running setup.py install for mozlog 03:29:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Running setup.py install for moznetwork 03:29:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Running setup.py install for mozprocess 03:29:57 INFO - Running setup.py install for mozprofile 03:29:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Running setup.py install for mozrunner 03:29:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Running setup.py install for mozscreenshot 03:29:57 INFO - Running setup.py install for moztest 03:29:57 INFO - Running setup.py install for mozversion 03:29:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:29:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:29:57 INFO - Cleaning up... 03:29:57 INFO - Return code: 0 03:29:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:57 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 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef090>, '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 0x2befd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', '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 03:29:57 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 03:29:57 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 03:29:57 INFO - Using env: {'DISPLAY': ':0', 03:29:57 INFO - 'HOME': '/home/cltbld', 03:29:57 INFO - 'LANG': 'en_US.UTF-8', 03:29:57 INFO - 'LANGUAGE': 'en_US:en', 03:29:57 INFO - 'LOGNAME': 'cltbld', 03:29:57 INFO - 'MAIL': '/var/mail/cltbld', 03:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:57 INFO - 'MOZ_NO_REMOTE': '1', 03:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:57 INFO - 'NO_EM_RESTART': '1', 03:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:57 INFO - 'PWD': '/builds/slave/test', 03:29:57 INFO - 'SHELL': '/bin/bash', 03:29:57 INFO - 'SHLVL': '1', 03:29:57 INFO - 'TERM': 'linux', 03:29:57 INFO - 'TMOUT': '86400', 03:29:57 INFO - 'USER': 'cltbld', 03:29:57 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', 03:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:57 INFO - '_': '/tools/buildbot/bin/python'} 03:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:58 INFO - Running setup.py (path:/tmp/pip-DCEoCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:58 INFO - Running setup.py (path:/tmp/pip-9YBeuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:58 INFO - Running setup.py (path:/tmp/pip-Nsc_VS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:58 INFO - Running setup.py (path:/tmp/pip-E2eMXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:58 INFO - Running setup.py (path:/tmp/pip-fXo4Fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:58 INFO - Running setup.py (path:/tmp/pip-9Gbgv6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:58 INFO - Running setup.py (path:/tmp/pip-8xzNAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:58 INFO - Running setup.py (path:/tmp/pip-IFFPVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:58 INFO - Running setup.py (path:/tmp/pip-xSi7Ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:58 INFO - Running setup.py (path:/tmp/pip-dnpRmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:58 INFO - Running setup.py (path:/tmp/pip-w8jUWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:58 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)) 03:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:58 INFO - Running setup.py (path:/tmp/pip-xQYrL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:59 INFO - Running setup.py (path:/tmp/pip-_fzpXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:59 INFO - Running setup.py (path:/tmp/pip-i_biQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:59 INFO - Running setup.py (path:/tmp/pip-gTKleE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:59 INFO - Running setup.py (path:/tmp/pip-rNg_Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:59 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)) 03:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:59 INFO - Running setup.py (path:/tmp/pip-7XkXXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:59 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)) 03:29:59 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)) 03:29:59 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)) 03:29:59 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)) 03:29:59 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)) 03:29:59 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)) 03:29:59 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)) 03:29:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:59 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 03:29:59 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 03:29:59 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 03:29:59 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 03:30:00 INFO - Downloading blessings-1.6.tar.gz 03:30:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:00 INFO - Installing collected packages: blessings 03:30:00 INFO - Running setup.py install for blessings 03:30:00 INFO - Successfully installed blessings 03:30:00 INFO - Cleaning up... 03:30:00 INFO - Return code: 0 03:30:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:00 INFO - Reading from file tmpfile_stdout 03:30:00 INFO - Current package versions: 03:30:00 INFO - argparse == 1.2.1 03:30:00 INFO - blessings == 1.6 03:30:00 INFO - blobuploader == 1.2.4 03:30:00 INFO - docopt == 0.6.1 03:30:00 INFO - functools32 == 3.2.3-2 03:30:00 INFO - jsonschema == 2.5.1 03:30:00 INFO - manifestparser == 1.1 03:30:00 INFO - mozInstall == 1.13 03:30:00 INFO - mozcrash == 1.0 03:30:00 INFO - mozdebug == 0.1 03:30:00 INFO - mozdevice == 0.51 03:30:00 INFO - mozfile == 1.2 03:30:00 INFO - mozhttpd == 0.7 03:30:00 INFO - mozinfo == 0.10 03:30:00 INFO - mozleak == 0.1 03:30:00 INFO - mozlog == 3.5 03:30:00 INFO - moznetwork == 0.27 03:30:00 INFO - mozprocess == 0.25 03:30:00 INFO - mozprofile == 0.28 03:30:00 INFO - mozrunner == 6.13 03:30:00 INFO - mozscreenshot == 0.1 03:30:00 INFO - mozsystemmonitor == 0.3 03:30:00 INFO - moztest == 0.8 03:30:00 INFO - mozversion == 1.4 03:30:00 INFO - psutil == 3.1.1 03:30:00 INFO - requests == 1.2.3 03:30:00 INFO - wsgiref == 0.1.2 03:30:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30: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')]} 03:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:00 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 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef090>, '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 0x2befd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', '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 03:30:00 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 03:30:00 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 03:30:00 INFO - Using env: {'DISPLAY': ':0', 03:30:00 INFO - 'HOME': '/home/cltbld', 03:30:00 INFO - 'LANG': 'en_US.UTF-8', 03:30:00 INFO - 'LANGUAGE': 'en_US:en', 03:30:00 INFO - 'LOGNAME': 'cltbld', 03:30:00 INFO - 'MAIL': '/var/mail/cltbld', 03:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:00 INFO - 'MOZ_NO_REMOTE': '1', 03:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:00 INFO - 'NO_EM_RESTART': '1', 03:30:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:00 INFO - 'PWD': '/builds/slave/test', 03:30:00 INFO - 'SHELL': '/bin/bash', 03:30:00 INFO - 'SHLVL': '1', 03:30:00 INFO - 'TERM': 'linux', 03:30:00 INFO - 'TMOUT': '86400', 03:30:00 INFO - 'USER': 'cltbld', 03:30:00 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', 03:30:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:00 INFO - '_': '/tools/buildbot/bin/python'} 03:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 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)) 03:30:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:30: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 03:30: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 03:30: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 03:30: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 03:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:30:02 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)) 03:30:02 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)) 03:30:02 INFO - Installing collected packages: simplejson 03:30:02 INFO - Running setup.py install for simplejson 03:30:02 INFO - building 'simplejson._speedups' extension 03:30:02 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 03:30:03 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 03:30:03 INFO - Successfully installed simplejson 03:30:03 INFO - Cleaning up... 03:30:03 INFO - Return code: 0 03:30:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x287f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2beba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bef090>, '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 0x2befd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9f90>, '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': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', '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 03:30:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:30:03 INFO - Using env: {'DISPLAY': ':0', 03:30:03 INFO - 'HOME': '/home/cltbld', 03:30:03 INFO - 'LANG': 'en_US.UTF-8', 03:30:03 INFO - 'LANGUAGE': 'en_US:en', 03:30:03 INFO - 'LOGNAME': 'cltbld', 03:30:03 INFO - 'MAIL': '/var/mail/cltbld', 03:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:03 INFO - 'MOZ_NO_REMOTE': '1', 03:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:03 INFO - 'NO_EM_RESTART': '1', 03:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:03 INFO - 'PWD': '/builds/slave/test', 03:30:03 INFO - 'SHELL': '/bin/bash', 03:30:03 INFO - 'SHLVL': '1', 03:30:03 INFO - 'TERM': 'linux', 03:30:03 INFO - 'TMOUT': '86400', 03:30:03 INFO - 'USER': 'cltbld', 03:30:03 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', 03:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:03 INFO - '_': '/tools/buildbot/bin/python'} 03:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:30:03 INFO - Cleaning up... 03:30:03 INFO - Return code: 0 03:30:03 INFO - Running post-action listener: _resource_record_post_action 03:30:03 INFO - Running post-action listener: _start_resource_monitoring 03:30:03 INFO - Starting resource monitoring. 03:30:03 INFO - [mozharness: 2017-09-12 10:30:03.639937Z] Finished create-virtualenv step (success) 03:30:03 INFO - [mozharness: 2017-09-12 10:30:03.640445Z] Running install step. 03:30:03 INFO - Running pre-action listener: _resource_record_pre_action 03:30:03 INFO - Running main action method: install 03:30:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:03 INFO - Reading from file tmpfile_stdout 03:30:03 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:03 INFO - Reading from file tmpfile_stdout 03:30:03 INFO - Output received: 03:30:03 INFO - Usage: mozinstall [options] installer 03:30:03 INFO - Options: 03:30:03 INFO - -h, --help show this help message and exit 03:30:03 INFO - -d DEST, --destination=DEST 03:30:03 INFO - Directory to install application into. [default: 03:30:03 INFO - "/builds/slave/test"] 03:30:03 INFO - --app=APP Application being installed. [default: firefox] 03:30:03 INFO - mkdir: /builds/slave/test/build/application 03:30:03 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'] 03:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:30:20 INFO - Reading from file tmpfile_stdout 03:30:20 INFO - Output received: 03:30:20 INFO - /builds/slave/test/build/application/firefox/firefox 03:30:20 INFO - Running post-action listener: _resource_record_post_action 03:30:20 INFO - [mozharness: 2017-09-12 10:30:20.647650Z] Finished install step (success) 03:30:20 INFO - [mozharness: 2017-09-12 10:30:20.647903Z] Running setup-mitmproxy step. 03:30:20 INFO - Running pre-action listener: _resource_record_pre_action 03:30:20 INFO - Running main action method: setup_mitmproxy 03:30:20 INFO - Skipping: mitmproxy is not required 03:30:20 INFO - Running post-action listener: _resource_record_post_action 03:30:20 INFO - [mozharness: 2017-09-12 10:30:20.649035Z] Finished setup-mitmproxy step (success) 03:30:20 INFO - [mozharness: 2017-09-12 10:30:20.649255Z] Running run-tests step. 03:30:20 INFO - Running pre-action listener: _resource_record_pre_action 03:30:20 INFO - Running pre-action listener: _set_gcov_prefix 03:30:20 INFO - Running main action method: run_tests 03:30:20 WARNING - Try message not found. 03:30:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:30:20 INFO - Python 2.7.3 03:30:20 INFO - Return code: 0 03:30:20 INFO - grabbing minidump binary from tooltool 03:30:20 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')]} 03:30:20 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 0x2bef090>, '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 0x2befd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be9f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:30:20 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 03:30:20 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 03:30:20 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 03:30:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:30:20 INFO - Return code: 0 03:30:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:30:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:30:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:30:20 INFO - ENV: RUST_BACKTRACE is now full 03:30:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:30:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:30:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 03:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 03:30:20 INFO - Using env: {'DISPLAY': ':0', 03:30:20 INFO - 'HOME': '/home/cltbld', 03:30:20 INFO - 'LANG': 'en_US.UTF-8', 03:30:20 INFO - 'LANGUAGE': 'en_US:en', 03:30:20 INFO - 'LOGNAME': 'cltbld', 03:30:20 INFO - 'MAIL': '/var/mail/cltbld', 03:30:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:30:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:20 INFO - 'MOZ_NO_REMOTE': '1', 03:30:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:20 INFO - 'NO_EM_RESTART': '1', 03:30:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:20 INFO - 'PWD': '/builds/slave/test', 03:30:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:30:20 INFO - 'RUST_BACKTRACE': 'full', 03:30:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:30:20 INFO - 'SHELL': '/bin/bash', 03:30:20 INFO - 'SHLVL': '1', 03:30:20 INFO - 'TERM': 'linux', 03:30:20 INFO - 'TMOUT': '86400', 03:30:20 INFO - 'USER': 'cltbld', 03:30:20 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', 03:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:20 INFO - '_': '/tools/buildbot/bin/python'} 03:30:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 03:30:21 INFO - mozversion application_buildid: 20170912093540 03:30:21 INFO - mozversion application_changeset: b0e945eed81db8bf076daf64e381c514f70144f0 03:30:21 INFO - mozversion application_display_name: Nightly 03:30:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:30:21 INFO - mozversion application_name: Firefox 03:30:21 INFO - mozversion application_remotingname: firefox 03:30:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:30:21 INFO - mozversion application_vendor: Mozilla 03:30:21 INFO - mozversion application_version: 57.0a1 03:30:21 INFO - mozversion platform_buildid: 20170912093540 03:30:21 INFO - mozversion platform_changeset: b0e945eed81db8bf076daf64e381c514f70144f0 03:30:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:30:21 INFO - mozversion platform_version: 57.0a1 03:30:21 INFO - using testdate: 1505212221 03:30:21 INFO - actual date: 1505212221 03:30:21 INFO - starting webserver on 'localhost:49463' 03:30:21 INFO - SUITE-START | Running 2 tests 03:30:21 INFO - TEST-START | dromaeo_css 03:30:21 INFO - Initialising browser for dromaeo_css test... 03:30:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49463/getInfo.html -profile /tmp/tmplMWo8L/profile 03:30:21 INFO - TEST-INFO | started process 2185 (/builds/slave/test/build/application/firefox/firefox http://localhost:49463/getInfo.html) 03:30:26 INFO - TEST-INFO | 2185: exit 0 03:30:26 INFO - Browser initialized. 03:30:26 INFO - Running cycle 1/1 for dromaeo_css test... 03:30:26 INFO - Using env: {'DISPLAY': ':0', 03:30:26 INFO - 'HOME': '/home/cltbld', 03:30:26 INFO - 'JSGC_DISABLE_POISONING': '1', 03:30:26 INFO - 'LANG': 'en_US.UTF-8', 03:30:26 INFO - 'LANGUAGE': 'en_US:en', 03:30:26 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:30:26 INFO - 'LOGNAME': 'cltbld', 03:30:26 INFO - 'MAIL': '/var/mail/cltbld', 03:30:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:30:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:30:26 INFO - 'MOZ_CRASHREPORTER': '1', 03:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:26 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:30:26 INFO - 'MOZ_NO_REMOTE': '1', 03:30:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:26 INFO - 'NO_EM_RESTART': '1', 03:30:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:26 INFO - 'PWD': '/builds/slave/test', 03:30:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:30:26 INFO - 'RUST_BACKTRACE': 'full', 03:30:26 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:30:26 INFO - 'SHELL': '/bin/bash', 03:30:26 INFO - 'SHLVL': '1', 03:30:26 INFO - 'STYLO_FORCE_DISABLED': '1', 03:30:26 INFO - 'TERM': 'linux', 03:30:26 INFO - 'TMOUT': '86400', 03:30:26 INFO - 'USER': 'cltbld', 03:30:26 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', 03:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:26 INFO - '_': '/tools/buildbot/bin/python'} 03:30:26 INFO - TEST-INFO | started process 2382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplMWo8L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:27 INFO - PID 2382 | 03:30:27 INFO - PID 2382 | (/builds/slave/test/build/application/firefox/firefox:2433): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:30:27 INFO - PID 2382 | 03:30:37 INFO - PID 2382 | RSS: Main: 170274816 03:30:37 INFO - PID 2382 | 03:33:34 INFO - PID 2382 | Cycle 1(1): loaded http://localhost:49463/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49463/tests/dromaeo/cssquery-ext.html) 03:33:35 INFO - PID 2382 | RSS: Main: 173002752 03:33:35 INFO - PID 2382 | 03:36:37 INFO - PID 2382 | Cycle 1(1): loaded http://localhost:49463/tests/dromaeo/cssquery-ext.html (next: http://localhost:49463/tests/dromaeo/cssquery-jquery.html) 03:36:38 INFO - PID 2382 | RSS: Main: 169426944 03:36:38 INFO - PID 2382 | 03:39:40 INFO - PID 2382 | Cycle 1(1): loaded http://localhost:49463/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49463/tests/dromaeo/cssquery-mootools.html) 03:39:40 INFO - PID 2382 | RSS: Main: 169844736 03:39:40 INFO - PID 2382 | 03:42:42 INFO - PID 2382 | Cycle 1(1): loaded http://localhost:49463/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49463/tests/dromaeo/cssquery-prototype.html) 03:42:43 INFO - PID 2382 | RSS: Main: 169893888 03:42:43 INFO - PID 2382 | 03:45:46 INFO - PID 2382 | Cycle 1(1): loaded http://localhost:49463/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49463/tests/dromaeo/cssquery-yui.html) 03:45:46 INFO - PID 2382 | RSS: Main: 171483136 03:45:46 INFO - PID 2382 | 03:48:48 INFO - PID 2382 | Cycle 1(1): loaded http://localhost:49463/tests/dromaeo/cssquery-yui.html (next: http://localhost:49463/tests/dromaeo/cssquery-dojo.html) 03:48:48 INFO - PID 2382 | RSS: Main: 174407680 03:48:48 INFO - PID 2382 | 03:48:48 INFO - PID 2382 | __start_tp_report 03:48:48 INFO - PID 2382 | _x_x_mozilla_page_load 03:48:48 INFO - PID 2382 | _x_x_mozilla_page_load_details 03:48:48 INFO - PID 2382 | |i|pagename|runs| 03:48:48 INFO - PID 2382 | |0;dojo.html;3098.3803239352137;3108.8445577721113;3139.9215019624494;3145.9685403145963;3146.150539354373;6135.631862088267;6152.753889844406;6197.721102550385;6218.689065546721;6244.500439964803;6177.876442471148;6275.372462753722;6294.716737746801;6298.11826344311;6350.904736428957;5680.176374425706;5715.342735585409;5735.11105778605;5815.098659707752;5853.443922827346;5607.915881261784;5669.09294512878;5710.371859095496;5740.7703691852275;5741.081426971686;5655.802046928358;5694.943050569504;5725.599208055417;5731.799387021434;5740.138979153118;5614.663120212759;5692.743826527775;5696.943030569682;5702;5715.657060576337;5564.860878478071;5640.210370548086;5648.802291919804;5709.543236541067;5716.771329146829;6174.722137503823;6233.594816336924;6289.654069026202;6292.779752708679;6308.873822523569;6576.868462630769;6608.669566521655;6678;6679.398854103154;6679.465642748617;6511.902321465182;6603.042558828943;6624.635645039521;6660.866782664368;6693.832654183636;6104.816855494387;6106.6336019838955;6111.602745821508;6121;6129.816105516842;6653.600783952978;6687.531872768956;6692.230393504809;6693.263740988487;6723.025161351577;6411.743530258831;6472.708728107153;6547.770828020996;6548.214214294315;6559.376859198369;6586.868262634721;6596.142501474874;6638.269790323061;6653.0020496925845;6662.700178491979;6290.591111577733;6468;6501.0898474213645;6528.08606795049;6608.372204640552;6599.868002639921;6618.205815302098;6628.370304821035;6639.86720265592;6692.966535167293;5181.404138524118;5241.528262456397;5243.370795504564;5251.606129540223;5252.054630166606;4505.549445055533;4543.273076307841;4549.363089167519;4555.248384016666;4572.862814115582;5703;5738.684372359477;5743.368229494752;5746.454086861825;5754.251947246915;6631.701573429207;6632.1046658701425;6699.095622091053;6714.932850671431;6717.429018533382;5721.4278572143285;5726.4273572642405;5746.051901436216;5788.681622510802;5799.5650326225705;5639.379668236491;5749.223854779635;5754.683492407958;5781.046127389018;5783.681897495594;6532.183477065367;6537.280899101095;6539.607623542603;6609.966950165219;6635.071090047397;6439.517036222396;6514.706838192387;6664.600123992479;6778.288279730557;6783.966080169567;6441.291457939529;6470.5147113965695;6509.479241660751;6517.902231466437;6519.967400162969;6454.225492940689;6455.709493072729;6469.708863101077;6561.507886908405;6576.967115164393;6469.28837827848;6604.8348791280605;6636.568623039487;6659.067730517828;6662.600243985376;6483.578567393104;6487.351264873475;6527.314631963575;6533.118029066205;6536.182977127859;6460.967695161494;6465.64438955862;6535.150430444012;6541.574797638138;6555.2133743951035;6220.253569571681;6350.714217860115;6364.681765911593;6434.292227855026;6473.482121430368;6437.38844809761;6477.801606702775;6530.216374034956;6595.274519802914;6596.076549283201;6238.937610623836;6247.937520624736;6296.024116261987;6336.398042185985;6336.7148478319505 03:48:48 INFO - PID 2382 | |1;ext.html;785.1834092543755;1200.3458115327148;1217.8416805815243;1222.853257609087;1228.0237211416922;37427.81286093569;40380;40552;40559.39160912589;40638.796806015926;38463.230735385274;38932.61067389325;38987.22025559487;39011.609883901154;39014.60985390145;7274.30894065063;7380.520266182708;7386.630668466582;7680.193579674137;7895;7682.692692292301;7781.455298129134;7784.455088143832;7786.493877897947;7787.065552133752;7734.381249500055;7744.303012728853;7758.185390533998;7759.5344279343135;7803.141654418009;7702.114256860476;7741;7775;7778.416618753616;7786.065672119354;7570.05374328209;7632.427567932427;7636.618169091523;7644.503107298008;7647.770566883002;37540.624593753986;37999.620003799886;38206.42690359647;38208.80895595532;38214.80892595547;3330.833458327074;3361.159710072482;3363.6468170841954;3376.2572234108457;3376.864925402981;31202.53196202059;31374.686253137632;31610.209744756336;31676.36647267065;31694.366112677846;5045.318881950926;5230.816921407771;5269.894602107936;5273.182656688219;5284.445133261029;189343;191341;192008.9999999986;192417;192487;41982.790086049376;42751.35872961908;49436;49506;49587.512374628815;50095.74952125216;50742.238866417036;50900.49099509032;50900.745496272284;50927.49072509302;14370.856291437161;14526.854731452762;14546;14550;14560.344784484723;11658.94170529142;11717.88282117185;11729.824052639216;11730.354830484406;11731.706707332385;14072.788908166385;14104;14121.435142594386;14130.15219086858;14213.360398782079;5507.807226747044;5530.806421775299;5549.361823390362;5563.499285064364;5624.100143976944;999.7850462150673;1007.793402352516;1017.9847302290472;1028.8199565076081;1035.6737627647267;22866.31401057971;22923.31230063101;23059.654105188434;23140.305790826304;23264.302070937898;1085.2728671789919;1093.2128867215592;1093.7593729379523;1101.4217535793612;1120.6133883810073;12091.697707557381;12185.390730463441;12207.755844883053;12212.633620991206;12325.322107284186;223591;225261;225641;226193;226544;53020.734896326045;53200.20199697008;53230;53261.467385326425;53722.73138634282;1400.4258254115966;1443.4370595467776;1444.7399468095844;1450.7896355028672;1453.5130731204954;22597.66103508416;22661.660075099215;22702.432439189153;23007.769922300562;23224.187153449548;35789.28421431609;35802.10494737652;35927.28145437129;35929.82035089808;36096.27807443784;191404;191545;191797;192607;193286;34055.318893621494;36881;37593.62406376011;37662.435063474615;37748.81125594355;46134.76932615315;46686.76656616695;46698.76650616725;47024;47080.52919470761;33584.66415335816;33841.83079084589;34126.31747364989;34374.656253438145;34807.651923480444;33728.39826537361;33737.325253495284;33867.830660846535;34113.123778192436;34715.47926781151;37646.811765941;37908.620913791616;38378.232435350576;38431.0392240185;38483.615163848;32534.349313013136;33241.174500167755;33268.334633307684;33513.16217094592;33954;22380.328590142322;22860.657090143995;22905.31284061481;23024.07903683834;23207.187748428725 03:48:48 INFO - PID 2382 | |2;jquery.html;545.3374150407254;547.6577139287945;555.7026990560051;568.3772828574421;589.9410058994101;22491.775082249173;23084.769152308472;23247;23254.41863953402;23271.883640581815;24143.758562414372;24539.141130060452;24899.626505602384;26087.347816304602;26313.605295920577;6312.842178945529;6444.516661250402;6449.903251451232;6454.677266136698;6493.448056915145;6327.715252813611;6423.710933008003;6431.710573024225;6437.130987316699;6801.319868013208;7066.752663656773;7125.608091554988;7127.03784989025;7128.429725621963;7161.319674630901;6694.732210711614;7036.577805331696;7071.116110486215;7099.361057504823;7116.928830711704;6826.931730682729;6844.349786770249;6888.517803753739;6892.586444813327;6907.102076729993;31208.21979450509;31807.522887156712;31979.200519986953;31987;31988.200294992577;2074.68879668051;2099.800518950697;2102.8843413612244;2103.8632488888175;2107.230860735836;18859.33992310276;20410.897945510176;20444.693329600068;20465.693014604793;20553.69169462459;2294.4952110535655;2360.5514952159206;2373.8724106049663;2376.9066229534433;2506.699196096462;123354.38322808419;128593;134545;139021;146228;19885.701714474293;20961.68557471639;22017.66973495399;22329.21847735354;22349.32952011442;44659.33011004837;44701.32948005782;44712;44743.32885006727;44757.55242447534;10713.625023124154;10799.190060745475;10873.619423320146;10900.182486313559;10907.236493445542;8889.111088891059;8989.46063236208;9018.63925442988;9065.59204835784;9120.635174592942;10983.39591322485;11000.559977600966;11266.155038371991;11516.94241528787;11704.648860534198;3638.381475149231;3696.7431073434623;3743.3636281832155;3963.286608410514;4126.442930204444;930.3022732950287;931.4132096778986;950.3727539823683;965.9517024148764;969.7672558585889;19697.40907772769;19704.70442943357;19941.202351905762;20066.197352106043;20155.0930208141;987.3434166279487;995.2983146881576;1001.0690058245756;1003.1573478278282;1010.7422607235108;10811;11048.281861678965;11167.218294719454;11176.664700059011;11286.322820630789;446641;458325;459296;461030;463684;108414.45792770985;111394;111466.44266778615;112183.4390828057;113456.86543134463;1029.5006921642996;1080.3140006096185;1126.6282126898104;1134.3364131982883;1185.6265276437894;21263.7873621268;21482.78517214808;21761.34715958524;21805.781942180376;21878.343649690534;56248;56784.43215567957;56906.43093569177;58299;58941.410585893595;69131;71366;71872.64063679648;72436.27563724296;72509.27490725025;20171.39485815428;20497.69253461229;20828.79171208329;20855.06152223184;20990.58018839584;23284.53430931406;23621.763782361955;23734;23811.76188238165;23849;18432.81567184311;18650.626987460448;18927.432177034712;19030.42908712741;19079.236830526625;15539.844601554292;16155.353785848434;16225.51323460298;16398.26207820627;16577.91711041437;18770.624587508446;18991.620167596295;18997.52506187301;19141.23435062582;19191.808081919004;20123.195072196948;20144.89927550353;20513.38459846207;20515.38453846387;20519.281825136048;18122.81877181211;18511.444656660322;18525;18656.16047277903;18656.78730882488 03:48:48 INFO - PID 2382 | |3;mootools.html;1328.249539010459;1393.707321462493;1394.4282844033942;1398.2100113435908;1406.9085509441886;14902.552923412288;15513.84486155138;15524.456644017462;15552.300146493406;15574.999999999985;15329.156896370696;15448.382064717398;15450.922745386286;15460.304286307115;15467.845321546782;2713.4301796622685;2843.9146825595267;2847.487452258593;2853.82877027378;2857.299961509433;2594.455164415475;2738.589211618263;2785.8607069646537;2789.121426750577;2795.3291210109633;2797.734215249548;2843.9715602844017;2856.942861142776;2861.728135827093;2870.784691148162;2738.342797728541;2757.062598716436;2762;2763.5163846326914;2765.046059109604;2649.827761195516;2679.42392385638;2682.0746842339363;2683.5035518429154;2686.7447592478684;14804.259787010606;15253.847461525354;15278.923605382013;15290.082595044332;15294.311755971008;8043.718469853527;8344.290735287508;8355.080941096474;8361.205685459872;8363.121872203452;5283.815066472694;5343.278657381243;5410.3507579090365;5481.068218402881;5531;1922.327185485083;1932.3623204342534;1935.764192357829;1977.2782934229047;1990.9800901991084;25990.35024124393;26587.202383928514;26710.19869403921;26817;26877;6809.5233333666165;6950.235474097845;7132.857342853114;7141.464390170758;7181.13826340832;17027.65944681124;17087.31650733957;17101.144942752813;17108.144592770313;17134.82865171357;7860.096088949729;8038;8047.1550487198;8049.839003219903;8072.878906816402;6827.419669328064;7037.612931288726;7038.542494737826;7264.455165862581;7419.2209817969415;5096.541311282002;5220.634555581149;5230.633855630145;5231.607629427808;5236.371635403776;1548.7444571645551;1551.4802541148615;1553.4795843392365;1575.59822245329;1577.250805867204;867.5922316511229;885.4156256870434;887.2325438495784;896.1352295035322;902.4404868981273;7312.634368281565;7375.594342311224;7405.666744996488;7417.072865891763;7470.178280389153;695.2213520856571;702.1924786495468;708.7979925721248;714.8534550417256;716.9175544812309;4327.788219298602;4361.956380436155;4395;4412.382266482695;4434.201843668106;19662.508437288896;20048.298309559097;20792.688109678365;21549.24577639775;21608.35174944723;18836.246550138116;19385.224591016482;19792.60414791696;19866.304679336445;19898;10576.57693692259;10639.89360106389;10676.306040107369;10680.893191068146;10734;7833.334166595675;7835.725749598737;7894.36845052383;7894.881576776238;8133.552654603817;18335.26658933681;18432.07839608041;18640.81359186391;18726.438206853818;18767.812321877154;19037.714434283775;19091.427257182306;19118.61762764709;19167.90416047911;19241.807581924;10296.3822170667;10500.842487362848;10551.94724026375;10562.735931601772;10675.679729608124;13587.252701101534;13777.931110344383;13778.242196679279;13778.448862045407;13782;10803.945980270362;10812.189085818438;10856;10973;11034.889651103707;10345.275830691779;10418.218633602663;10476.476176191007;10491.213159012952;10679.839802403125;9529.714108576754;9536.618535258513;9638.180754635654;9672.903270967201;9680.93509713945;7199.748008819666;7206.099237595301;7210.783676489714;7245.963770181115;7422.220666829905;6970.686319115754;7041.753538626123;7090.255523169993;7103.786886393416;7123.074000379917 03:48:48 INFO - PID 2382 | |4;prototype.html;496.8741922204244;517.7799435240023;519.2600544224484;522.3940229333971;530.7399374306589;6327.810165695031;6400.679966001693;6417.582857114296;6423.086338950695;6428.421442070213;6205.968970155154;6210.627362358262;6214.968925155368;6271.498280137589;6345.873082538358;5170.146925757245;5212.270282160501;5212.504812042859;5235.738213089349;5248.895022099556;4861.465238823745;5190.506901844337;5212.400573934008;5219.869503262411;5222.216667499867;4991.326170966928;5013.498650134994;5022.773975171126;5027.874303142414;5030.270610761438;4987.725675087869;4996.4254110777365;5030.572401345872;5034.59723222145;5043.5965122790085;4489.9551004490195;4499.820007199708;4500.559820857327;4500.819967201308;4502.369668246415;6191.637839675264;6199.225096862892;6208;6225.906611400833;6255;5635.351934527541;5698.6580805151825;5771.163181338724;5774.2782152230975;5775.480206781368;6385.616862988236;6483.957553370673;6498.9350106498805;6533.529955759964;6560.901586476207;4837.0567739290855;4867.82962596311;4878.43897951733;4882.121218180726;4904.852854414374;6574.704138313788;6672.366125218096;6753.189617245913;6798.8300292492095;6810.795676129675;4913.729744864067;4925.556699897026;4934.605231581465;4954.108260513142;4981.526754958273;4974.975125124423;4978.153713868651;5020.196768517019;5040.79836806531;5045.091883461012;5578.30271216098;5591.52472039873;5613.578981576316;5646.265985421869;5680.204771332017;6522.445592124628;6566.5403421760975;6567.540272180901;6610.7025183866845;6640.966795165993;1716.6652502761842;1730.965380692379;1744.5202569293292;1752.1677203328572;1764.8764586478824;1148.6783700563856;1193.9910775394778;1194.5281613762515;1211.8303437518755;1229.4037391864938;5659.490645841894;5701.315842098892;5702.8289151325525;5732.512736417368;5748.5688573357165;6613.206415230107;6621.768238111739;6644.83387915306;6645.368689974444;6659.736729002851;5594.496495315359;5631.63394379364;5633.155026745939;5669.376368599451;5685.403032681509;3531.3643544161782;3539.6283390243652;3579.3713860193548;3581.7313701472494;3582.710224319243;6483.4164925156965;6488.513361497907;6494.415502604788;6506.41442270198;6536.7580159769495;6839.179298484214;6864.141982252218;6881.311868813079;6894.207166175854;6913.064341984253;6450.161928751334;6546.18172728409;6547.116139321226;6568.653426047745;6572.76995305162;6143.262808463013;6518.185226846645;6563.0811686362995;6641.9667901662115;6701.1623547056615;6302.802467531154;6459.870802584016;6532.085508028785;6583.473322134314;6632.4694024478895;6367.936320636734;6444.8388790280615;6485.416312531895;6510.707018184288;6580.8354791130605;4757.785899634456;4934.5312195341385;4962.503749625009;4969.726665033458;4986.8753281168265;6309.6023511065505;6558.278589355072;6559.934400655932;6675.766348177791;6779.254282029072;6374.553781235454;6425.979789498928;6445.1943507061615;6483.4115641668095;6541.313162118099;6350.841228969312;6383.234011918599;6406.679666016587;6473.967630161819;6497.285298617054;6401.519886008475;6427.807165785034;6438.356164383524;6474.611523308617;6494.6752662367635;6515;6530.47756179514;6598.60408375499;6603.2171313745985;6644.800655980328;6290.622562646256;6313.337099604475;6352.174217351715;6376.426121649074;6388.584741991755 03:48:48 INFO - PID 2382 | |5;yui.html;873.7771868173614;892.2772554231074;900.9009009009012;909.4770506958499;939.9859002114968;14813.481528146503;15158;15159.166245856473;15165.545033648981;15220.695586088286;15687.529374118794;15735.763963540556;15745.685086298296;15747.448839290628;15759.92120039401;945.6122989574293;956.0582825916466;958.0754571838174;960.9519524023806;961.8701475300815;966.3766870368609;970.5438443931341;970.6942313171364;971.3977334052862;971.6016433262364;972.4408465132542;1009.379231772462;1019.9235057370689;1020.2603112743276;1020.6580795433539;1008.425197637347;1010.8938561451052;1012.3015119567549;1012.3824467075115;1012.4178597306504;718.2135561560083;738.0368618952265;743.1750756660103;744;746.3767753925479;16568.585785355343;16701.49895503137;16705.749413758804;16763.664726705396;16940.3223871045;21303.893480532653;21365.35903922885;21459.67810482844;21512;21989.780102198933;15701.528954131394;15909.52271431859;15922.920385398114;16029.759553606706;16037.2783224754;3703.1112532992156;3761.2101458693705;3764.3412402829395;3773.0378753417704;3786.5077539919635;100801.4959925203;108937.45531272372;135315.32342338323;136030;138060.30969845186;16243.918780406022;16260.430884918971;16376.672466550603;16508.6698266034;16542.338306467605;31019;31810.681893181234;31884.521732174035;31909.68090319067;31927.680723192934;8153.796155096052;8169.591520423955;8187.959060204661;8243.8351232975;8330.458520196167;3903.531576210873;3962.9603703963166;3978;3983.6813054956115;3996.4604778355133;5335.893282134413;5442.346918369821;5450.31871016123;5451.890962180813;5470.234167216593;1018.332991890313;1032.7108409645311;1040.0587468341164;1040.2718097331897;1044.6761503933806;614.8800983808204;625.3746253746253;630.4893036640336;633.6293268437923;653.9993809471516;10742.03321701035;11061.446927653586;11407.201495895373;11620.477078531487;12260.754784904251;616.9753209871644;622.7197761007565;626.5394934722975;642.0882347067176;648.4844548583793;5613;5624.746886390122;5636.154576813429;5740.770369185269;5763.567732420085;114082.42958785153;116808.41595792136;119470;119532.40233798775;123040;99202.50398748105;100644;100803.49598251961;101295.49352253192;101509;84681;85238;86574;86996.56501717451;87326;10402.895971040496;10431.321964072311;10456.738581535219;10738;10763.892361076289;43647;43975.340369893835;45731.77134114308;46293.305600416694;47160.292595611776;55685;56702.7164864173;58493.122603161835;59120.40879591149;59753.103703445355;14414.927925360305;14699.779503307673;14750.778738319148;14839.33223004989;14992.550223493312;15969;15989.120598366737;16057.116858572423;16199.190040497691;16266.349346026027;13337.933310333387;13634.522791702242;13643.863561364657;13734.175949442666;13752.243626600633;13956.302184890917;14249.145051296955;14266.072705274124;14363.856361436252;14407.135571865721;14782.852171478147;14805.407783688532;14894.851051489346;15011.249437527862;15012.6997460048;11027.889721102687;11141;11261.66215013551;11414.543418263176;11562.826557601475;12163.695907602381;12215.755684886075;12253.60841229856;12312.445939932546;12316 03:48:48 INFO - PID 2382 | __end_tp_report 03:48:48 INFO - PID 2382 | __start_cc_report 03:48:48 INFO - PID 2382 | _x_x_mozilla_cycle_collect,377 03:48:48 INFO - PID 2382 | __end_cc_report 03:48:48 INFO - PID 2382 | __startTimestamp1505213328650__endTimestamp 03:48:48 INFO - PID 2382 | 03:48:48 INFO - PID 2382 | ------- Summary: start ------- 03:48:48 INFO - PID 2382 | Number of tests: 6 03:48:48 INFO - PID 2382 | 03:48:48 INFO - PID 2382 | [#0] dojo.html Cycles:165 Average:6102.85 Median:6350.90 stddev:723.74 (11.4%) stddev-sans-first:686.51 03:48:48 INFO - PID 2382 | Values: 3098.4 3108.8 3139.9 3146.0 3146.2 6135.6 6152.8 6197.7 6218.7 6244.5 6177.9 6275.4 6294.7 6298.1 6350.9 5680.2 5715.3 5735.1 5815.1 5853.4 5607.9 5669.1 5710.4 5740.8 5741.1 5655.8 5694.9 5725.6 5731.8 5740.1 5614.7 5692.7 5696.9 5702.0 5715.7 5564.9 5640.2 5648.8 5709.5 5716.8 6174.7 6233.6 6289.7 6292.8 6308.9 6576.9 6608.7 6678.0 6679.4 6679.5 6511.9 6603.0 6624.6 6660.9 6693.8 6104.8 6106.6 6111.6 6121.0 6129.8 6653.6 6687.5 6692.2 6693.3 6723.0 6411.7 6472.7 6547.8 6548.2 6559.4 6586.9 6596.1 6638.3 6653.0 6662.7 6290.6 6468.0 6501.1 6528.1 6608.4 6599.9 6618.2 6628.4 6639.9 6693.0 5181.4 5241.5 5243.4 5251.6 5252.1 4505.5 4543.3 4549.4 4555.2 4572.9 5703.0 5738.7 5743.4 5746.5 5754.3 6631.7 6632.1 6699.1 6714.9 6717.4 5721.4 5726.4 5746.1 5788.7 5799.6 5639.4 5749.2 5754.7 5781.0 5783.7 6532.2 6537.3 6539.6 6610.0 6635.1 6439.5 6514.7 6664.6 6778.3 6784.0 6441.3 6470.5 6509.5 6517.9 6520.0 6454.2 6455.7 6469.7 6561.5 6577.0 6469.3 6604.8 6636.6 6659.1 6662.6 6483.6 6487.4 6527.3 6533.1 6536.2 6461.0 6465.6 6535.2 6541.6 6555.2 6220.3 6350.7 6364.7 6434.3 6473.5 6437.4 6477.8 6530.2 6595.3 6596.1 6238.9 6247.9 6296.0 6336.4 6336.7 03:48:48 INFO - PID 2382 | 03:48:48 INFO - PID 2382 | [#1] ext.html Cycles:180 Average:37381.55 Median:34250.49 stddev:52752.30 (154.0%) stddev-sans-first:52828.71 03:48:48 INFO - PID 2382 | Values: 785.2 1200.3 1217.8 1222.9 1228.0 37427.8 40380.0 40552.0 40559.4 40638.8 38463.2 38932.6 38987.2 39011.6 39014.6 7274.3 7380.5 7386.6 7680.2 7895.0 7682.7 7781.5 7784.5 7786.5 7787.1 7734.4 7744.3 7758.2 7759.5 7803.1 7702.1 7741.0 7775.0 7778.4 7786.1 7570.1 7632.4 7636.6 7644.5 7647.8 37540.6 37999.6 38206.4 38208.8 38214.8 3330.8 3361.2 3363.6 3376.3 3376.9 31202.5 31374.7 31610.2 31676.4 31694.4 5045.3 5230.8 5269.9 5273.2 5284.4 189343.0 191341.0 192009.0 192417.0 192487.0 41982.8 42751.4 49436.0 49506.0 49587.5 50095.7 50742.2 50900.5 50900.7 50927.5 14370.9 14526.9 14546.0 14550.0 14560.3 11658.9 11717.9 11729.8 11730.4 11731.7 14072.8 14104.0 14121.4 14130.2 14213.4 5507.8 5530.8 5549.4 5563.5 5624.1 999.8 1007.8 1018.0 1028.8 1035.7 22866.3 22923.3 23059.7 23140.3 23264.3 1085.3 1093.2 1093.8 1101.4 1120.6 12091.7 12185.4 12207.8 12212.6 12325.3 223591.0 225261.0 225641.0 226193.0 226544.0 53020.7 53200.2 53230.0 53261.5 53722.7 1400.4 1443.4 1444.7 1450.8 1453.5 22597.7 22661.7 22702.4 23007.8 23224.2 35789.3 35802.1 35927.3 35929.8 36096.3 191404.0 191545.0 191797.0 192607.0 193286.0 34055.3 36881.0 37593.6 37662.4 37748.8 46134.8 46686.8 46698.8 47024.0 47080.5 33584.7 33841.8 34126.3 34374.7 34807.7 33728.4 33737.3 33867.8 34113.1 34715.5 37646.8 37908.6 38378.2 38431.0 38483.6 32534.3 33241.2 33268.3 33513.2 33954.0 22380.3 22860.7 22905.3 23024.1 23207.2 03:48:48 INFO - PID 2382 | 03:48:48 INFO - PID 2382 | [#2] jquery.html Cycles:180 Average:35158.68 Median:23165.88 stddev:77203.84 (333.3%) stddev-sans-first:77376.68 03:48:48 INFO - PID 2382 | Values: 545.3 547.7 555.7 568.4 589.9 22491.8 23084.8 23247.0 23254.4 23271.9 24143.8 24539.1 24899.6 26087.3 26313.6 6312.8 6444.5 6449.9 6454.7 6493.4 6327.7 6423.7 6431.7 6437.1 6801.3 7066.8 7125.6 7127.0 7128.4 7161.3 6694.7 7036.6 7071.1 7099.4 7116.9 6826.9 6844.3 6888.5 6892.6 6907.1 31208.2 31807.5 31979.2 31987.0 31988.2 2074.7 2099.8 2102.9 2103.9 2107.2 18859.3 20410.9 20444.7 20465.7 20553.7 2294.5 2360.6 2373.9 2376.9 2506.7 123354.4 128593.0 134545.0 139021.0 146228.0 19885.7 20961.7 22017.7 22329.2 22349.3 44659.3 44701.3 44712.0 44743.3 44757.6 10713.6 10799.2 10873.6 10900.2 10907.2 8889.1 8989.5 9018.6 9065.6 9120.6 10983.4 11000.6 11266.2 11516.9 11704.6 3638.4 3696.7 3743.4 3963.3 4126.4 930.3 931.4 950.4 966.0 969.8 19697.4 19704.7 19941.2 20066.2 20155.1 987.3 995.3 1001.1 1003.2 1010.7 10811.0 11048.3 11167.2 11176.7 11286.3 446641.0 458325.0 459296.0 461030.0 463684.0 108414.5 111394.0 111466.4 112183.4 113456.9 1029.5 1080.3 1126.6 1134.3 1185.6 21263.8 21482.8 21761.3 21805.8 21878.3 56248.0 56784.4 56906.4 58299.0 58941.4 69131.0 71366.0 71872.6 72436.3 72509.3 20171.4 20497.7 20828.8 20855.1 20990.6 23284.5 23621.8 23734.0 23811.8 23849.0 18432.8 18650.6 18927.4 19030.4 19079.2 15539.8 16155.4 16225.5 16398.3 16577.9 18770.6 18991.6 18997.5 19141.2 19191.8 20123.2 20144.9 20513.4 20515.4 20519.3 18122.8 18511.4 18525.0 18656.2 18656.8 03:48:48 INFO - PID 2382 | 03:48:48 INFO - PID 2382 | [#3] mootools.html Cycles:180 Average:9140.77 Median:14795.22 stddev:6544.31 (44.2%) stddev-sans-first:6536.34 03:48:48 INFO - PID 2382 | Values: 1328.2 1393.7 1394.4 1398.2 1406.9 14902.6 15513.8 15524.5 15552.3 15575.0 15329.2 15448.4 15450.9 15460.3 15467.8 2713.4 2843.9 2847.5 2853.8 2857.3 2594.5 2738.6 2785.9 2789.1 2795.3 2797.7 2844.0 2856.9 2861.7 2870.8 2738.3 2757.1 2762.0 2763.5 2765.0 2649.8 2679.4 2682.1 2683.5 2686.7 14804.3 15253.8 15278.9 15290.1 15294.3 8043.7 8344.3 8355.1 8361.2 8363.1 5283.8 5343.3 5410.4 5481.1 5531.0 1922.3 1932.4 1935.8 1977.3 1991.0 25990.4 26587.2 26710.2 26817.0 26877.0 6809.5 6950.2 7132.9 7141.5 7181.1 17027.7 17087.3 17101.1 17108.1 17134.8 7860.1 8038.0 8047.2 8049.8 8072.9 6827.4 7037.6 7038.5 7264.5 7419.2 5096.5 5220.6 5230.6 5231.6 5236.4 1548.7 1551.5 1553.5 1575.6 1577.3 867.6 885.4 887.2 896.1 902.4 7312.6 7375.6 7405.7 7417.1 7470.2 695.2 702.2 708.8 714.9 716.9 4327.8 4362.0 4395.0 4412.4 4434.2 19662.5 20048.3 20792.7 21549.2 21608.4 18836.2 19385.2 19792.6 19866.3 19898.0 10576.6 10639.9 10676.3 10680.9 10734.0 7833.3 7835.7 7894.4 7894.9 8133.6 18335.3 18432.1 18640.8 18726.4 18767.8 19037.7 19091.4 19118.6 19167.9 19241.8 10296.4 10500.8 10551.9 10562.7 10675.7 13587.3 13777.9 13778.2 13778.4 13782.0 10803.9 10812.2 10856.0 10973.0 11034.9 10345.3 10418.2 10476.5 10491.2 10679.8 9529.7 9536.6 9638.2 9672.9 9680.9 7199.7 7206.1 7210.8 7246.0 7422.2 6970.7 7041.8 7090.3 7103.8 7123.1 03:48:48 INFO - PID 2382 | 03:48:48 INFO - PID 2382 | [#4] prototype.html Cycles:180 Average:5497.13 Median:6212.80 stddev:1531.33 (24.6%) stddev-sans-first:1488.93 03:48:48 INFO - PID 2382 | Values: 496.9 517.8 519.3 522.4 530.7 6327.8 6400.7 6417.6 6423.1 6428.4 6206.0 6210.6 6215.0 6271.5 6345.9 5170.1 5212.3 5212.5 5235.7 5248.9 4861.5 5190.5 5212.4 5219.9 5222.2 4991.3 5013.5 5022.8 5027.9 5030.3 4987.7 4996.4 5030.6 5034.6 5043.6 4490.0 4499.8 4500.6 4500.8 4502.4 6191.6 6199.2 6208.0 6225.9 6255.0 5635.4 5698.7 5771.2 5774.3 5775.5 6385.6 6484.0 6498.9 6533.5 6560.9 4837.1 4867.8 4878.4 4882.1 4904.9 6574.7 6672.4 6753.2 6798.8 6810.8 4913.7 4925.6 4934.6 4954.1 4981.5 4975.0 4978.2 5020.2 5040.8 5045.1 5578.3 5591.5 5613.6 5646.3 5680.2 6522.4 6566.5 6567.5 6610.7 6641.0 1716.7 1731.0 1744.5 1752.2 1764.9 1148.7 1194.0 1194.5 1211.8 1229.4 5659.5 5701.3 5702.8 5732.5 5748.6 6613.2 6621.8 6644.8 6645.4 6659.7 5594.5 5631.6 5633.2 5669.4 5685.4 3531.4 3539.6 3579.4 3581.7 3582.7 6483.4 6488.5 6494.4 6506.4 6536.8 6839.2 6864.1 6881.3 6894.2 6913.1 6450.2 6546.2 6547.1 6568.7 6572.8 6143.3 6518.2 6563.1 6642.0 6701.2 6302.8 6459.9 6532.1 6583.5 6632.5 6367.9 6444.8 6485.4 6510.7 6580.8 4757.8 4934.5 4962.5 4969.7 4986.9 6309.6 6558.3 6559.9 6675.8 6779.3 6374.6 6426.0 6445.2 6483.4 6541.3 6350.8 6383.2 6406.7 6474.0 6497.3 6401.5 6427.8 6438.4 6474.6 6494.7 6515.0 6530.5 6598.6 6603.2 6644.8 6290.6 6313.3 6352.2 6376.4 6388.6 03:48:48 INFO - PID 2382 | 03:48:48 INFO - PID 2382 | [#5] yui.html Cycles:180 Average:22770.78 Median:16442.67 stddev:32789.52 (199.4%) stddev-sans-first:32840.29 03:48:48 INFO - PID 2382 | Values: 873.8 892.3 900.9 909.5 940.0 14813.5 15158.0 15159.2 15165.5 15220.7 15687.5 15735.8 15745.7 15747.4 15759.9 945.6 956.1 958.1 961.0 961.9 966.4 970.5 970.7 971.4 971.6 972.4 1009.4 1019.9 1020.3 1020.7 1008.4 1010.9 1012.3 1012.4 1012.4 718.2 738.0 743.2 744.0 746.4 16568.6 16701.5 16705.7 16763.7 16940.3 21303.9 21365.4 21459.7 21512.0 21989.8 15701.5 15909.5 15922.9 16029.8 16037.3 3703.1 3761.2 3764.3 3773.0 3786.5 100801.5 108937.5 135315.3 136030.0 138060.3 16243.9 16260.4 16376.7 16508.7 16542.3 31019.0 31810.7 31884.5 31909.7 31927.7 8153.8 8169.6 8188.0 8243.8 8330.5 3903.5 3963.0 3978.0 3983.7 3996.5 5335.9 5442.3 5450.3 5451.9 5470.2 1018.3 1032.7 1040.1 1040.3 1044.7 614.9 625.4 630.5 633.6 654.0 10742.0 11061.4 11407.2 11620.5 12260.8 617.0 622.7 626.5 642.1 648.5 5613.0 5624.7 5636.2 5740.8 5763.6 114082.4 116808.4 119470.0 119532.4 123040.0 99202.5 100644.0 100803.5 101295.5 101509.0 84681.0 85238.0 86574.0 86996.6 87326.0 10402.9 10431.3 10456.7 10738.0 10763.9 43647.0 43975.3 45731.8 46293.3 47160.3 55685.0 56702.7 58493.1 59120.4 59753.1 14414.9 14699.8 14750.8 14839.3 14992.6 15969.0 15989.1 16057.1 16199.2 16266.3 13337.9 13634.5 13643.9 13734.2 13752.2 13956.3 14249.1 14266.1 14363.9 14407.1 14782.9 14805.4 14894.9 15011.2 15012.7 11027.9 11141.0 11261.7 11414.5 11562.8 12163.7 12215.8 12253.6 12312.4 12316.0 03:48:48 INFO - PID 2382 | -------- Summary: end -------- 03:48:48 INFO - PID 2382 | 03:48:48 INFO - PID 2382 | 03:48:48 INFO - PID 2382 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 03:48:48 INFO - PID 2382 | 03:48:49 INFO - TEST-INFO | 2382: exit 0 03:48:49 INFO - TEST-OK | dromaeo_css | took 1108357ms 03:48:49 INFO - TEST-START | kraken 03:48:49 INFO - Initialising browser for kraken test... 03:48:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49463/getInfo.html -profile /tmp/tmp84Tw66/profile 03:48:49 INFO - TEST-INFO | started process 2847 (/builds/slave/test/build/application/firefox/firefox http://localhost:49463/getInfo.html) 03:48:54 INFO - TEST-INFO | 2847: exit 0 03:48:54 INFO - Browser initialized. 03:48:54 INFO - Running cycle 1/1 for kraken test... 03:48:54 INFO - Using env: {'DISPLAY': ':0', 03:48:54 INFO - 'HOME': '/home/cltbld', 03:48:54 INFO - 'JSGC_DISABLE_POISONING': '1', 03:48:54 INFO - 'LANG': 'en_US.UTF-8', 03:48:54 INFO - 'LANGUAGE': 'en_US:en', 03:48:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:48:54 INFO - 'LOGNAME': 'cltbld', 03:48:54 INFO - 'MAIL': '/var/mail/cltbld', 03:48:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:48:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:48:54 INFO - 'MOZ_CRASHREPORTER': '1', 03:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:48:55 INFO - 'MOZ_NO_REMOTE': '1', 03:48:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:55 INFO - 'NO_EM_RESTART': '1', 03:48:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:55 INFO - 'PWD': '/builds/slave/test', 03:48:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:48:55 INFO - 'RUST_BACKTRACE': 'full', 03:48:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:48:55 INFO - 'SHELL': '/bin/bash', 03:48:55 INFO - 'SHLVL': '1', 03:48:55 INFO - 'STYLO_FORCE_DISABLED': '1', 03:48:55 INFO - 'TERM': 'linux', 03:48:55 INFO - 'TMOUT': '86400', 03:48:55 INFO - 'USER': 'cltbld', 03:48:55 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176', 03:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:55 INFO - '_': '/tools/buildbot/bin/python'} 03:48:55 INFO - TEST-INFO | started process 3134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp84Tw66/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:55 INFO - PID 3134 | 03:48:55 INFO - PID 3134 | (/builds/slave/test/build/application/firefox/firefox:3203): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:48:55 INFO - PID 3134 | 03:49:06 INFO - PID 3134 | RSS: Main: 170479616 03:49:06 INFO - PID 3134 | 03:49:08 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49463/tests/kraken/driver.html?testName=audio-beat-detection) 03:49:09 INFO - PID 3134 | RSS: Main: 177061888 03:49:09 INFO - PID 3134 | 03:49:12 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49463/tests/kraken/driver.html?testName=audio-dft) 03:49:13 INFO - PID 3134 | RSS: Main: 176893952 03:49:13 INFO - PID 3134 | 03:49:16 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49463/tests/kraken/driver.html?testName=audio-fft) 03:49:16 INFO - PID 3134 | RSS: Main: 171081728 03:49:16 INFO - PID 3134 | 03:49:18 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49463/tests/kraken/driver.html?testName=audio-oscillator) 03:49:19 INFO - PID 3134 | RSS: Main: 171745280 03:49:19 INFO - PID 3134 | 03:49:21 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49463/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:49:22 INFO - PID 3134 | RSS: Main: 172314624 03:49:22 INFO - PID 3134 | 03:49:25 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49463/tests/kraken/driver.html?testName=imaging-darkroom) 03:49:26 INFO - PID 3134 | RSS: Main: 174931968 03:49:26 INFO - PID 3134 | 03:49:29 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49463/tests/kraken/driver.html?testName=imaging-desaturate) 03:49:30 INFO - PID 3134 | RSS: Main: 175116288 03:49:30 INFO - PID 3134 | 03:49:33 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49463/tests/kraken/driver.html?testName=json-parse-financial) 03:49:33 INFO - PID 3134 | RSS: Main: 174940160 03:49:33 INFO - PID 3134 | 03:49:35 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49463/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:36 INFO - PID 3134 | RSS: Main: 175026176 03:49:36 INFO - PID 3134 | 03:49:37 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49463/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:38 INFO - PID 3134 | RSS: Main: 174878720 03:49:38 INFO - PID 3134 | 03:49:40 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49463/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:41 INFO - PID 3134 | RSS: Main: 172007424 03:49:41 INFO - PID 3134 | 03:49:43 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49463/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:44 INFO - PID 3134 | RSS: Main: 171921408 03:49:44 INFO - PID 3134 | 03:49:47 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49463/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:48 INFO - PID 3134 | RSS: Main: 172048384 03:49:48 INFO - PID 3134 | 03:49:49 INFO - PID 3134 | Cycle 1(1): loaded http://localhost:49463/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49463/tests/kraken/driver.html?testName=ai-astar) 03:49:50 INFO - PID 3134 | RSS: Main: 173961216 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | __start_tp_report 03:49:50 INFO - PID 3134 | _x_x_mozilla_page_load 03:49:50 INFO - PID 3134 | _x_x_mozilla_page_load_details 03:49:50 INFO - PID 3134 | |i|pagename|runs| 03:49:50 INFO - PID 3134 | |0;ai-astar;110;108;108;106;108;110;109;108;108;107 03:49:50 INFO - PID 3134 | |1;audio-beat-detection;123;122;117;118;118;117;115;139;117;117 03:49:50 INFO - PID 3134 | |2;audio-dft;162;161;161;163;164;163;165;166;168;165 03:49:50 INFO - PID 3134 | |3;audio-fft;73;73;74;72;76;78;80;77;74;75 03:49:50 INFO - PID 3134 | |4;audio-oscillator;79;79;80;80;79;78;79;80;79;80 03:49:50 INFO - PID 3134 | |5;imaging-gaussian-blur;113;114;114;114;115;114;115;110;114;114 03:49:50 INFO - PID 3134 | |6;imaging-darkroom;147;147;150;150;148;148;148;149;148;148 03:49:50 INFO - PID 3134 | |7;imaging-desaturate;96;93;94;94;100;94;94;95;94;94 03:49:50 INFO - PID 3134 | |8;json-parse-financial;53;54;54;55;64;54;55;59;53;51 03:49:50 INFO - PID 3134 | |9;json-stringify-tinderbox;38;39;38;39;39;39;39;39;38;39 03:49:50 INFO - PID 3134 | |10;stanford-crypto-aes;73;75;81;73;74;76;75;74;77;77 03:49:50 INFO - PID 3134 | |11;stanford-crypto-ccm;122;115;116;119;118;117;115;113;119;114 03:49:50 INFO - PID 3134 | |12;stanford-crypto-pbkdf2;167;170;165;171;168;174;172;169;169;176 03:49:50 INFO - PID 3134 | |13;stanford-crypto-sha256-iterative;70;71;66;70;66;63;69;64;69;65 03:49:50 INFO - PID 3134 | __end_tp_report 03:49:50 INFO - PID 3134 | __start_cc_report 03:49:50 INFO - PID 3134 | _x_x_mozilla_cycle_collect,924 03:49:50 INFO - PID 3134 | __end_cc_report 03:49:50 INFO - PID 3134 | __startTimestamp1505213390177__endTimestamp 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | ------- Summary: start ------- 03:49:50 INFO - PID 3134 | Number of tests: 14 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#0] ai-astar Cycles:10 Average:108.20 Median:108.00 stddev:1.23 (1.1%) stddev-sans-first:1.12 03:49:50 INFO - PID 3134 | Values: 110.0 108.0 108.0 106.0 108.0 110.0 109.0 108.0 108.0 107.0 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#1] audio-beat-detection Cycles:10 Average:120.30 Median:118.00 stddev:7.01 (5.9%) stddev-sans-first:7.37 03:49:50 INFO - PID 3134 | Values: 123.0 122.0 117.0 118.0 118.0 117.0 115.0 139.0 117.0 117.0 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.50 stddev:2.25 (1.4%) stddev-sans-first:2.29 03:49:50 INFO - PID 3134 | Values: 162.0 161.0 161.0 163.0 164.0 163.0 165.0 166.0 168.0 165.0 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#3] audio-fft Cycles:10 Average:75.20 Median:75.50 stddev:2.53 (3.4%) stddev-sans-first:2.55 03:49:50 INFO - PID 3134 | Values: 73.0 73.0 74.0 72.0 76.0 78.0 80.0 77.0 74.0 75.0 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:79.50 stddev:0.67 (0.8%) stddev-sans-first:0.71 03:49:50 INFO - PID 3134 | Values: 79.0 79.0 80.0 80.0 79.0 78.0 79.0 80.0 79.0 80.0 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.42 (1.2%) stddev-sans-first:1.48 03:49:50 INFO - PID 3134 | Values: 113.0 114.0 114.0 114.0 115.0 114.0 115.0 110.0 114.0 114.0 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:1.06 (0.7%) stddev-sans-first:1.01 03:49:50 INFO - PID 3134 | Values: 147.0 147.0 150.0 150.0 148.0 148.0 148.0 149.0 148.0 148.0 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:1.99 (2.1%) stddev-sans-first:2.06 03:49:50 INFO - PID 3134 | Values: 96.0 93.0 94.0 94.0 100.0 94.0 94.0 95.0 94.0 94.0 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.50 stddev:3.71 (6.8%) stddev-sans-first:3.84 03:49:50 INFO - PID 3134 | Values: 53.0 54.0 54.0 55.0 64.0 54.0 55.0 59.0 53.0 51.0 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#9] json-stringify-tinderbox Cycles:10 Average:38.70 Median:39.00 stddev:0.48 (1.2%) stddev-sans-first:0.44 03:49:50 INFO - PID 3134 | Values: 38.0 39.0 38.0 39.0 39.0 39.0 39.0 39.0 38.0 39.0 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.50 stddev:2.42 (3.2%) stddev-sans-first:2.39 03:49:50 INFO - PID 3134 | Values: 73.0 75.0 81.0 73.0 74.0 76.0 75.0 74.0 77.0 77.0 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:117.50 stddev:2.74 (2.3%) stddev-sans-first:2.17 03:49:50 INFO - PID 3134 | Values: 122.0 115.0 116.0 119.0 118.0 117.0 115.0 113.0 119.0 114.0 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:170.50 stddev:3.28 (1.9%) stddev-sans-first:3.28 03:49:50 INFO - PID 3134 | Values: 167.0 170.0 165.0 171.0 168.0 174.0 172.0 169.0 169.0 176.0 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:69.00 stddev:2.83 (4.1%) stddev-sans-first:2.83 03:49:50 INFO - PID 3134 | Values: 70.0 71.0 66.0 70.0 66.0 63.0 69.0 64.0 69.0 65.0 03:49:50 INFO - PID 3134 | -------- Summary: end -------- 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | ###!!! [Parent][RunMessage] Error: Channel closing: too late to send/recv, messages will be lost 03:49:50 INFO - PID 3134 | 03:49:50 INFO - PID 3134 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:49:50 INFO - TEST-INFO | 3134: exit 0 03:49:50 INFO - TEST-OK | kraken | took 61530ms 03:49:50 INFO - SUITE-END | took 1169s 03:49:51 INFO - Completed test suite (00:19:30) 03:49:51 INFO - javascript benchmark 03:49:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8489.868686927748, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3098.3803239352137, 3108.8445577721113, 3139.9215019624494, 3145.9685403145963, 3146.150539354373, 6135.631862088267, 6152.753889844406, 6197.721102550385, 6218.689065546721, 6244.500439964803, 6177.876442471148, 6275.372462753722, 6294.716737746801, 6298.11826344311, 6350.904736428957, 5680.176374425706, 5715.342735585409, 5735.11105778605, 5815.098659707752, 5853.443922827346, 5607.915881261784, 5669.09294512878, 5710.371859095496, 5740.7703691852275, 5741.081426971686, 5655.802046928358, 5694.943050569504, 5725.599208055417, 5731.799387021434, 5740.138979153118, 5614.663120212759, 5692.743826527775, 5696.943030569682, 5702.0, 5715.657060576337, 5564.860878478071, 5640.210370548086, 5648.802291919804, 5709.543236541067, 5716.771329146829, 6174.722137503823, 6233.594816336924, 6289.654069026202, 6292.779752708679, 6308.873822523569, 6576.868462630769, 6608.669566521655, 6678.0, 6679.398854103154, 6679.465642748617, 6511.902321465182, 6603.042558828943, 6624.635645039521, 6660.866782664368, 6693.832654183636, 6104.816855494387, 6106.6336019838955, 6111.602745821508, 6121.0, 6129.816105516842, 6653.600783952978, 6687.531872768956, 6692.230393504809, 6693.263740988487, 6723.025161351577, 6411.743530258831, 6472.708728107153, 6547.770828020996, 6548.214214294315, 6559.376859198369, 6586.868262634721, 6596.142501474874, 6638.269790323061, 6653.0020496925845, 6662.700178491979, 6290.591111577733, 6468.0, 6501.0898474213645, 6528.08606795049, 6608.372204640552, 6599.868002639921, 6618.205815302098, 6628.370304821035, 6639.86720265592, 6692.966535167293, 5181.404138524118, 5241.528262456397, 5243.370795504564, 5251.606129540223, 5252.054630166606, 4505.549445055533, 4543.273076307841, 4549.363089167519, 4555.248384016666, 4572.862814115582, 5703.0, 5738.684372359477, 5743.368229494752, 5746.454086861825, 5754.251947246915, 6631.701573429207, 6632.1046658701425, 6699.095622091053, 6714.932850671431, 6717.429018533382, 5721.4278572143285, 5726.4273572642405, 5746.051901436216, 5788.681622510802, 5799.5650326225705, 5639.379668236491, 5749.223854779635, 5754.683492407958, 5781.046127389018, 5783.681897495594, 6532.183477065367, 6537.280899101095, 6539.607623542603, 6609.966950165219, 6635.071090047397, 6439.517036222396, 6514.706838192387, 6664.600123992479, 6778.288279730557, 6783.966080169567, 6441.291457939529, 6470.5147113965695, 6509.479241660751, 6517.902231466437, 6519.967400162969, 6454.225492940689, 6455.709493072729, 6469.708863101077, 6561.507886908405, 6576.967115164393, 6469.28837827848, 6604.8348791280605, 6636.568623039487, 6659.067730517828, 6662.600243985376, 6483.578567393104, 6487.351264873475, 6527.314631963575, 6533.118029066205, 6536.182977127859, 6460.967695161494, 6465.64438955862, 6535.150430444012, 6541.574797638138, 6555.2133743951035, 6220.253569571681, 6350.714217860115, 6364.681765911593, 6434.292227855026, 6473.482121430368, 6437.38844809761, 6477.801606702775, 6530.216374034956, 6595.274519802914, 6596.076549283201, 6238.937610623836, 6247.937520624736, 6296.024116261987, 6336.398042185985, 6336.7148478319505], "value": 6048.077479550332, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.1834092543755, 1200.3458115327148, 1217.8416805815243, 1222.853257609087, 1228.0237211416922, 37427.81286093569, 40380.0, 40552.0, 40559.39160912589, 40638.796806015926, 38463.230735385274, 38932.61067389325, 38987.22025559487, 39011.609883901154, 39014.60985390145, 7274.30894065063, 7380.520266182708, 7386.630668466582, 7680.193579674137, 7895.0, 7682.692692292301, 7781.455298129134, 7784.455088143832, 7786.493877897947, 7787.065552133752, 7734.381249500055, 7744.303012728853, 7758.185390533998, 7759.5344279343135, 7803.141654418009, 7702.114256860476, 7741.0, 7775.0, 7778.416618753616, 7786.065672119354, 7570.05374328209, 7632.427567932427, 7636.618169091523, 7644.503107298008, 7647.770566883002, 37540.624593753986, 37999.620003799886, 38206.42690359647, 38208.80895595532, 38214.80892595547, 3330.833458327074, 3361.159710072482, 3363.6468170841954, 3376.2572234108457, 3376.864925402981, 31202.53196202059, 31374.686253137632, 31610.209744756336, 31676.36647267065, 31694.366112677846, 5045.318881950926, 5230.816921407771, 5269.894602107936, 5273.182656688219, 5284.445133261029, 189343.0, 191341.0, 192008.9999999986, 192417.0, 192487.0, 41982.790086049376, 42751.35872961908, 49436.0, 49506.0, 49587.512374628815, 50095.74952125216, 50742.238866417036, 50900.49099509032, 50900.745496272284, 50927.49072509302, 14370.856291437161, 14526.854731452762, 14546.0, 14550.0, 14560.344784484723, 11658.94170529142, 11717.88282117185, 11729.824052639216, 11730.354830484406, 11731.706707332385, 14072.788908166385, 14104.0, 14121.435142594386, 14130.15219086858, 14213.360398782079, 5507.807226747044, 5530.806421775299, 5549.361823390362, 5563.499285064364, 5624.100143976944, 999.7850462150673, 1007.793402352516, 1017.9847302290472, 1028.8199565076081, 1035.6737627647267, 22866.31401057971, 22923.31230063101, 23059.654105188434, 23140.305790826304, 23264.302070937898, 1085.2728671789919, 1093.2128867215592, 1093.7593729379523, 1101.4217535793612, 1120.6133883810073, 12091.697707557381, 12185.390730463441, 12207.755844883053, 12212.633620991206, 12325.322107284186, 223591.0, 225261.0, 225641.0, 226193.0, 226544.0, 53020.734896326045, 53200.20199697008, 53230.0, 53261.467385326425, 53722.73138634282, 1400.4258254115966, 1443.4370595467776, 1444.7399468095844, 1450.7896355028672, 1453.5130731204954, 22597.66103508416, 22661.660075099215, 22702.432439189153, 23007.769922300562, 23224.187153449548, 35789.28421431609, 35802.10494737652, 35927.28145437129, 35929.82035089808, 36096.27807443784, 191404.0, 191545.0, 191797.0, 192607.0, 193286.0, 34055.318893621494, 36881.0, 37593.62406376011, 37662.435063474615, 37748.81125594355, 46134.76932615315, 46686.76656616695, 46698.76650616725, 47024.0, 47080.52919470761, 33584.66415335816, 33841.83079084589, 34126.31747364989, 34374.656253438145, 34807.651923480444, 33728.39826537361, 33737.325253495284, 33867.830660846535, 34113.123778192436, 34715.47926781151, 37646.811765941, 37908.620913791616, 38378.232435350576, 38431.0392240185, 38483.615163848, 32534.349313013136, 33241.174500167755, 33268.334633307684, 33513.16217094592, 33954.0, 22380.328590142322, 22860.657090143995, 22905.31284061481, 23024.07903683834, 23207.187748428725], "value": 17196.108044419194, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.3374150407254, 547.6577139287945, 555.7026990560051, 568.3772828574421, 589.9410058994101, 22491.775082249173, 23084.769152308472, 23247.0, 23254.41863953402, 23271.883640581815, 24143.758562414372, 24539.141130060452, 24899.626505602384, 26087.347816304602, 26313.605295920577, 6312.842178945529, 6444.516661250402, 6449.903251451232, 6454.677266136698, 6493.448056915145, 6327.715252813611, 6423.710933008003, 6431.710573024225, 6437.130987316699, 6801.319868013208, 7066.752663656773, 7125.608091554988, 7127.03784989025, 7128.429725621963, 7161.319674630901, 6694.732210711614, 7036.577805331696, 7071.116110486215, 7099.361057504823, 7116.928830711704, 6826.931730682729, 6844.349786770249, 6888.517803753739, 6892.586444813327, 6907.102076729993, 31208.21979450509, 31807.522887156712, 31979.200519986953, 31987.0, 31988.200294992577, 2074.68879668051, 2099.800518950697, 2102.8843413612244, 2103.8632488888175, 2107.230860735836, 18859.33992310276, 20410.897945510176, 20444.693329600068, 20465.693014604793, 20553.69169462459, 2294.4952110535655, 2360.5514952159206, 2373.8724106049663, 2376.9066229534433, 2506.699196096462, 123354.38322808419, 128593.0, 134545.0, 139021.0, 146228.0, 19885.701714474293, 20961.68557471639, 22017.66973495399, 22329.21847735354, 22349.32952011442, 44659.33011004837, 44701.32948005782, 44712.0, 44743.32885006727, 44757.55242447534, 10713.625023124154, 10799.190060745475, 10873.619423320146, 10900.182486313559, 10907.236493445542, 8889.111088891059, 8989.46063236208, 9018.63925442988, 9065.59204835784, 9120.635174592942, 10983.39591322485, 11000.559977600966, 11266.155038371991, 11516.94241528787, 11704.648860534198, 3638.381475149231, 3696.7431073434623, 3743.3636281832155, 3963.286608410514, 4126.442930204444, 930.3022732950287, 931.4132096778986, 950.3727539823683, 965.9517024148764, 969.7672558585889, 19697.40907772769, 19704.70442943357, 19941.202351905762, 20066.197352106043, 20155.0930208141, 987.3434166279487, 995.2983146881576, 1001.0690058245756, 1003.1573478278282, 1010.7422607235108, 10811.0, 11048.281861678965, 11167.218294719454, 11176.664700059011, 11286.322820630789, 446641.0, 458325.0, 459296.0, 461030.0, 463684.0, 108414.45792770985, 111394.0, 111466.44266778615, 112183.4390828057, 113456.86543134463, 1029.5006921642996, 1080.3140006096185, 1126.6282126898104, 1134.3364131982883, 1185.6265276437894, 21263.7873621268, 21482.78517214808, 21761.34715958524, 21805.781942180376, 21878.343649690534, 56248.0, 56784.43215567957, 56906.43093569177, 58299.0, 58941.410585893595, 69131.0, 71366.0, 71872.64063679648, 72436.27563724296, 72509.27490725025, 20171.39485815428, 20497.69253461229, 20828.79171208329, 20855.06152223184, 20990.58018839584, 23284.53430931406, 23621.763782361955, 23734.0, 23811.76188238165, 23849.0, 18432.81567184311, 18650.626987460448, 18927.432177034712, 19030.42908712741, 19079.236830526625, 15539.844601554292, 16155.353785848434, 16225.51323460298, 16398.26207820627, 16577.91711041437, 18770.624587508446, 18991.620167596295, 18997.52506187301, 19141.23435062582, 19191.808081919004, 20123.195072196948, 20144.89927550353, 20513.38459846207, 20515.38453846387, 20519.281825136048, 18122.81877181211, 18511.444656660322, 18525.0, 18656.16047277903, 18656.78730882488], "value": 12887.159278291152, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.249539010459, 1393.707321462493, 1394.4282844033942, 1398.2100113435908, 1406.9085509441886, 14902.552923412288, 15513.84486155138, 15524.456644017462, 15552.300146493406, 15574.999999999985, 15329.156896370696, 15448.382064717398, 15450.922745386286, 15460.304286307115, 15467.845321546782, 2713.4301796622685, 2843.9146825595267, 2847.487452258593, 2853.82877027378, 2857.299961509433, 2594.455164415475, 2738.589211618263, 2785.8607069646537, 2789.121426750577, 2795.3291210109633, 2797.734215249548, 2843.9715602844017, 2856.942861142776, 2861.728135827093, 2870.784691148162, 2738.342797728541, 2757.062598716436, 2762.0, 2763.5163846326914, 2765.046059109604, 2649.827761195516, 2679.42392385638, 2682.0746842339363, 2683.5035518429154, 2686.7447592478684, 14804.259787010606, 15253.847461525354, 15278.923605382013, 15290.082595044332, 15294.311755971008, 8043.718469853527, 8344.290735287508, 8355.080941096474, 8361.205685459872, 8363.121872203452, 5283.815066472694, 5343.278657381243, 5410.3507579090365, 5481.068218402881, 5531.0, 1922.327185485083, 1932.3623204342534, 1935.764192357829, 1977.2782934229047, 1990.9800901991084, 25990.35024124393, 26587.202383928514, 26710.19869403921, 26817.0, 26877.0, 6809.5233333666165, 6950.235474097845, 7132.857342853114, 7141.464390170758, 7181.13826340832, 17027.65944681124, 17087.31650733957, 17101.144942752813, 17108.144592770313, 17134.82865171357, 7860.096088949729, 8038.0, 8047.1550487198, 8049.839003219903, 8072.878906816402, 6827.419669328064, 7037.612931288726, 7038.542494737826, 7264.455165862581, 7419.2209817969415, 5096.541311282002, 5220.634555581149, 5230.633855630145, 5231.607629427808, 5236.371635403776, 1548.7444571645551, 1551.4802541148615, 1553.4795843392365, 1575.59822245329, 1577.250805867204, 867.5922316511229, 885.4156256870434, 887.2325438495784, 896.1352295035322, 902.4404868981273, 7312.634368281565, 7375.594342311224, 7405.666744996488, 7417.072865891763, 7470.178280389153, 695.2213520856571, 702.1924786495468, 708.7979925721248, 714.8534550417256, 716.9175544812309, 4327.788219298602, 4361.956380436155, 4395.0, 4412.382266482695, 4434.201843668106, 19662.508437288896, 20048.298309559097, 20792.688109678365, 21549.24577639775, 21608.35174944723, 18836.246550138116, 19385.224591016482, 19792.60414791696, 19866.304679336445, 19898.0, 10576.57693692259, 10639.89360106389, 10676.306040107369, 10680.893191068146, 10734.0, 7833.334166595675, 7835.725749598737, 7894.36845052383, 7894.881576776238, 8133.552654603817, 18335.26658933681, 18432.07839608041, 18640.81359186391, 18726.438206853818, 18767.812321877154, 19037.714434283775, 19091.427257182306, 19118.61762764709, 19167.90416047911, 19241.807581924, 10296.3822170667, 10500.842487362848, 10551.94724026375, 10562.735931601772, 10675.679729608124, 13587.252701101534, 13777.931110344383, 13778.242196679279, 13778.448862045407, 13782.0, 10803.945980270362, 10812.189085818438, 10856.0, 10973.0, 11034.889651103707, 10345.275830691779, 10418.218633602663, 10476.476176191007, 10491.213159012952, 10679.839802403125, 9529.714108576754, 9536.618535258513, 9638.180754635654, 9672.903270967201, 9680.93509713945, 7199.748008819666, 7206.099237595301, 7210.783676489714, 7245.963770181115, 7422.220666829905, 6970.686319115754, 7041.753538626123, 7090.255523169993, 7103.786886393416, 7123.074000379917], "value": 6526.985767371016, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.8741922204244, 517.7799435240023, 519.2600544224484, 522.3940229333971, 530.7399374306589, 6327.810165695031, 6400.679966001693, 6417.582857114296, 6423.086338950695, 6428.421442070213, 6205.968970155154, 6210.627362358262, 6214.968925155368, 6271.498280137589, 6345.873082538358, 5170.146925757245, 5212.270282160501, 5212.504812042859, 5235.738213089349, 5248.895022099556, 4861.465238823745, 5190.506901844337, 5212.400573934008, 5219.869503262411, 5222.216667499867, 4991.326170966928, 5013.498650134994, 5022.773975171126, 5027.874303142414, 5030.270610761438, 4987.725675087869, 4996.4254110777365, 5030.572401345872, 5034.59723222145, 5043.5965122790085, 4489.9551004490195, 4499.820007199708, 4500.559820857327, 4500.819967201308, 4502.369668246415, 6191.637839675264, 6199.225096862892, 6208.0, 6225.906611400833, 6255.0, 5635.351934527541, 5698.6580805151825, 5771.163181338724, 5774.2782152230975, 5775.480206781368, 6385.616862988236, 6483.957553370673, 6498.9350106498805, 6533.529955759964, 6560.901586476207, 4837.0567739290855, 4867.82962596311, 4878.43897951733, 4882.121218180726, 4904.852854414374, 6574.704138313788, 6672.366125218096, 6753.189617245913, 6798.8300292492095, 6810.795676129675, 4913.729744864067, 4925.556699897026, 4934.605231581465, 4954.108260513142, 4981.526754958273, 4974.975125124423, 4978.153713868651, 5020.196768517019, 5040.79836806531, 5045.091883461012, 5578.30271216098, 5591.52472039873, 5613.578981576316, 5646.265985421869, 5680.204771332017, 6522.445592124628, 6566.5403421760975, 6567.540272180901, 6610.7025183866845, 6640.966795165993, 1716.6652502761842, 1730.965380692379, 1744.5202569293292, 1752.1677203328572, 1764.8764586478824, 1148.6783700563856, 1193.9910775394778, 1194.5281613762515, 1211.8303437518755, 1229.4037391864938, 5659.490645841894, 5701.315842098892, 5702.8289151325525, 5732.512736417368, 5748.5688573357165, 6613.206415230107, 6621.768238111739, 6644.83387915306, 6645.368689974444, 6659.736729002851, 5594.496495315359, 5631.63394379364, 5633.155026745939, 5669.376368599451, 5685.403032681509, 3531.3643544161782, 3539.6283390243652, 3579.3713860193548, 3581.7313701472494, 3582.710224319243, 6483.4164925156965, 6488.513361497907, 6494.415502604788, 6506.41442270198, 6536.7580159769495, 6839.179298484214, 6864.141982252218, 6881.311868813079, 6894.207166175854, 6913.064341984253, 6450.161928751334, 6546.18172728409, 6547.116139321226, 6568.653426047745, 6572.76995305162, 6143.262808463013, 6518.185226846645, 6563.0811686362995, 6641.9667901662115, 6701.1623547056615, 6302.802467531154, 6459.870802584016, 6532.085508028785, 6583.473322134314, 6632.4694024478895, 6367.936320636734, 6444.8388790280615, 6485.416312531895, 6510.707018184288, 6580.8354791130605, 4757.785899634456, 4934.5312195341385, 4962.503749625009, 4969.726665033458, 4986.8753281168265, 6309.6023511065505, 6558.278589355072, 6559.934400655932, 6675.766348177791, 6779.254282029072, 6374.553781235454, 6425.979789498928, 6445.1943507061615, 6483.4115641668095, 6541.313162118099, 6350.841228969312, 6383.234011918599, 6406.679666016587, 6473.967630161819, 6497.285298617054, 6401.519886008475, 6427.807165785034, 6438.356164383524, 6474.611523308617, 6494.6752662367635, 6515.0, 6530.47756179514, 6598.60408375499, 6603.2171313745985, 6644.800655980328, 6290.622562646256, 6313.337099604475, 6352.174217351715, 6376.426121649074, 6388.584741991755], "value": 5045.040363512473, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.7771868173614, 892.2772554231074, 900.9009009009012, 909.4770506958499, 939.9859002114968, 14813.481528146503, 15158.0, 15159.166245856473, 15165.545033648981, 15220.695586088286, 15687.529374118794, 15735.763963540556, 15745.685086298296, 15747.448839290628, 15759.92120039401, 945.6122989574293, 956.0582825916466, 958.0754571838174, 960.9519524023806, 961.8701475300815, 966.3766870368609, 970.5438443931341, 970.6942313171364, 971.3977334052862, 971.6016433262364, 972.4408465132542, 1009.379231772462, 1019.9235057370689, 1020.2603112743276, 1020.6580795433539, 1008.425197637347, 1010.8938561451052, 1012.3015119567549, 1012.3824467075115, 1012.4178597306504, 718.2135561560083, 738.0368618952265, 743.1750756660103, 744.0, 746.3767753925479, 16568.585785355343, 16701.49895503137, 16705.749413758804, 16763.664726705396, 16940.3223871045, 21303.893480532653, 21365.35903922885, 21459.67810482844, 21512.0, 21989.780102198933, 15701.528954131394, 15909.52271431859, 15922.920385398114, 16029.759553606706, 16037.2783224754, 3703.1112532992156, 3761.2101458693705, 3764.3412402829395, 3773.0378753417704, 3786.5077539919635, 100801.4959925203, 108937.45531272372, 135315.32342338323, 136030.0, 138060.30969845186, 16243.918780406022, 16260.430884918971, 16376.672466550603, 16508.6698266034, 16542.338306467605, 31019.0, 31810.681893181234, 31884.521732174035, 31909.68090319067, 31927.680723192934, 8153.796155096052, 8169.591520423955, 8187.959060204661, 8243.8351232975, 8330.458520196167, 3903.531576210873, 3962.9603703963166, 3978.0, 3983.6813054956115, 3996.4604778355133, 5335.893282134413, 5442.346918369821, 5450.31871016123, 5451.890962180813, 5470.234167216593, 1018.332991890313, 1032.7108409645311, 1040.0587468341164, 1040.2718097331897, 1044.6761503933806, 614.8800983808204, 625.3746253746253, 630.4893036640336, 633.6293268437923, 653.9993809471516, 10742.03321701035, 11061.446927653586, 11407.201495895373, 11620.477078531487, 12260.754784904251, 616.9753209871644, 622.7197761007565, 626.5394934722975, 642.0882347067176, 648.4844548583793, 5613.0, 5624.746886390122, 5636.154576813429, 5740.770369185269, 5763.567732420085, 114082.42958785153, 116808.41595792136, 119470.0, 119532.40233798775, 123040.0, 99202.50398748105, 100644.0, 100803.49598251961, 101295.49352253192, 101509.0, 84681.0, 85238.0, 86574.0, 86996.56501717451, 87326.0, 10402.895971040496, 10431.321964072311, 10456.738581535219, 10738.0, 10763.892361076289, 43647.0, 43975.340369893835, 45731.77134114308, 46293.305600416694, 47160.292595611776, 55685.0, 56702.7164864173, 58493.122603161835, 59120.40879591149, 59753.103703445355, 14414.927925360305, 14699.779503307673, 14750.778738319148, 14839.33223004989, 14992.550223493312, 15969.0, 15989.120598366737, 16057.116858572423, 16199.190040497691, 16266.349346026027, 13337.933310333387, 13634.522791702242, 13643.863561364657, 13734.175949442666, 13752.243626600633, 13956.302184890917, 14249.145051296955, 14266.072705274124, 14363.856361436252, 14407.135571865721, 14782.852171478147, 14805.407783688532, 14894.851051489346, 15011.249437527862, 15012.6997460048, 11027.889721102687, 11141.0, 11261.66215013551, 11414.543418263176, 11562.826557601475, 12163.695907602381, 12215.755684886075, 12253.60841229856, 12312.445939932546, 12316.0], "value": 8483.912463090768, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 108.0, 108.0, 106.0, 108.0, 110.0, 109.0, 108.0, 108.0, 107.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 117.0, 118.0, 118.0, 117.0, 115.0, 139.0, 117.0, 117.0], "value": 120.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 163.0, 164.0, 163.0, 165.0, 166.0, 168.0, 165.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 72.0, 76.0, 78.0, 80.0, 77.0, 74.0, 75.0], "value": 75.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 80.0, 79.0, 78.0, 79.0, 80.0, 79.0, 80.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 110.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 150.0, 150.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 93.0, 94.0, 94.0, 100.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 55.0, 64.0, 54.0, 55.0, 59.0, 53.0, 51.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 39.0, 39.0, 39.0, 39.0, 39.0, 38.0, 39.0], "value": 38.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 81.0, 73.0, 74.0, 76.0, 75.0, 74.0, 77.0, 77.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 115.0, 116.0, 119.0, 118.0, 117.0, 115.0, 113.0, 119.0, 114.0], "value": 116.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 165.0, 171.0, 168.0, 174.0, 172.0, 169.0, 169.0, 176.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 66.0, 70.0, 66.0, 63.0, 69.0, 64.0, 69.0, 65.0], "value": 67.3, "unit": "score"}]}]} 03:49:51 INFO - Return code: 0 03:49:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:49:51 INFO - # TBPL SUCCESS # 03:49:51 INFO - Running post-action listener: _package_coverage_data 03:49:51 INFO - Running post-action listener: _resource_record_post_action 03:49:51 INFO - [mozharness: 2017-09-12 10:49:51.487513Z] Finished run-tests step (success) 03:49:51 INFO - Running post-run listener: _resource_record_post_run 03:49:51 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297750528; Read time: 8; Write time: 159976 03:49:51 INFO - TinderboxPrint: CPU usage
13.1% 03:49:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:49:51 INFO - TinderboxPrint: I/O write bytes / time
297,750,528 / 159,976 03:49:51 INFO - TinderboxPrint: CPU idle
8,222.4 (86.9%) 03:49:51 INFO - TinderboxPrint: CPU user
1,191.8 (12.6%) 03:49:51 INFO - TinderboxPrint: Swap in / out
0 / 0 03:49:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13336576; Read time: 0; Write time: 2592 03:49:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:49:51 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284413952; Read time: 8; Write time: 157384 03:49:52 INFO - Running post-run listener: _upload_blobber_files 03:49:52 INFO - Blob upload gear active. 03:49:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:52 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 03:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:49:52 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:49:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:49:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:53 INFO - (blobuploader) - INFO - Done attempting. 03:49:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:49:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:49:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:54 INFO - (blobuploader) - INFO - Done attempting. 03:49:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:49:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:50:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:02 INFO - (blobuploader) - INFO - Done attempting. 03:50:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:50:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:50:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:03 INFO - (blobuploader) - INFO - Done attempting. 03:50:03 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:03 INFO - Return code: 0 03:50:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3554e4ae3063de72d4b8dae93848be730bf4ffa199199af5f34f01f3454406c6bd05a844bdbef3f0088f13e3bdb7e3c1fc1a32e429509665c27f75190651205", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f6a2ecec4d2a38e744507b62e503230aaf158bdb298daeafadad212ef04ed947f7d19d4698533996d1cf9bcc3d917113d4440a586ee79fb989f3a0351294872", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c736e9192f9f9945c3089d013b9df614424afb76738f98b0df87f8fda5da01be1a80773e91db6fe2a7ee571e5df14b0993919717044207fab17396b8b2170ace", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4a501e76e65fb4a6b6c474061e3a9eb0da42ff570dcb0d8969db9bed3cfd733fbbfe0c060d922ee5c45871c355cd622ba5e78bc3773f6e2e894c2af7943f2e63"} 03:50:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:03 INFO - Contents: 03:50:03 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3554e4ae3063de72d4b8dae93848be730bf4ffa199199af5f34f01f3454406c6bd05a844bdbef3f0088f13e3bdb7e3c1fc1a32e429509665c27f75190651205", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f6a2ecec4d2a38e744507b62e503230aaf158bdb298daeafadad212ef04ed947f7d19d4698533996d1cf9bcc3d917113d4440a586ee79fb989f3a0351294872", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c736e9192f9f9945c3089d013b9df614424afb76738f98b0df87f8fda5da01be1a80773e91db6fe2a7ee571e5df14b0993919717044207fab17396b8b2170ace", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4a501e76e65fb4a6b6c474061e3a9eb0da42ff570dcb0d8969db9bed3cfd733fbbfe0c060d922ee5c45871c355cd622ba5e78bc3773f6e2e894c2af7943f2e63"} 03:50:03 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:03 INFO - Copying logs to upload dir... 03:50:03 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.917175 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-12 03:50:03.413566) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 03:50:03.416847) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3554e4ae3063de72d4b8dae93848be730bf4ffa199199af5f34f01f3454406c6bd05a844bdbef3f0088f13e3bdb7e3c1fc1a32e429509665c27f75190651205", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f6a2ecec4d2a38e744507b62e503230aaf158bdb298daeafadad212ef04ed947f7d19d4698533996d1cf9bcc3d917113d4440a586ee79fb989f3a0351294872", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c736e9192f9f9945c3089d013b9df614424afb76738f98b0df87f8fda5da01be1a80773e91db6fe2a7ee571e5df14b0993919717044207fab17396b8b2170ace", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4a501e76e65fb4a6b6c474061e3a9eb0da42ff570dcb0d8969db9bed3cfd733fbbfe0c060d922ee5c45871c355cd622ba5e78bc3773f6e2e894c2af7943f2e63"} build_url:https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/Z7UnFtVmTZqJN21MF8D_IQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c3554e4ae3063de72d4b8dae93848be730bf4ffa199199af5f34f01f3454406c6bd05a844bdbef3f0088f13e3bdb7e3c1fc1a32e429509665c27f75190651205", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5f6a2ecec4d2a38e744507b62e503230aaf158bdb298daeafadad212ef04ed947f7d19d4698533996d1cf9bcc3d917113d4440a586ee79fb989f3a0351294872", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c736e9192f9f9945c3089d013b9df614424afb76738f98b0df87f8fda5da01be1a80773e91db6fe2a7ee571e5df14b0993919717044207fab17396b8b2170ace", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4a501e76e65fb4a6b6c474061e3a9eb0da42ff570dcb0d8969db9bed3cfd733fbbfe0c060d922ee5c45871c355cd622ba5e78bc3773f6e2e894c2af7943f2e63"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-12 03:50:03.445862) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:50:03.446204) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1505194062.447392-969190176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-12 03:50:03.530309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 03:50:03.530631) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-12 03:50:03.530925) ========= ========= Total master_lag: 0.21 =========