builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1506763110.53 results: success (0) revision: 19f368b1267d67f1bc214abae058ec20cb532c64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-30 02:18:30.529381) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-30 02:18:30.530187) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-30 02:18:30.530471) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-30 02:18:30.581737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 02:18:30.582134) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-30 02:18:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2017-09-30 02:18:30 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146986 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 02:18:30.769627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 02:18:30.769943) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020354 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 02:18:30.819994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-30 02:18:30.820504) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 19f368b1267d67f1bc214abae058ec20cb532c64 --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 19f368b1267d67f1bc214abae058ec20cb532c64 --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=516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-30 02:18:30,881 truncating revision to first 12 chars 2017-09-30 02:18:30,881 Setting DEBUG logging. 2017-09-30 02:18:30,881 attempt 1/10 2017-09-30 02:18:30,881 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/19f368b1267d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-30 02:18:31,268 attempt 1/10 2017-09-30 02:18:32,547 current task status: no status available at this point. state: STARTED 2017-09-30 02:18:32,548 sleeping for 11.00s (attempt 1/10) 2017-09-30 02:18:43,559 attempt 2/10 2017-09-30 02:18:43,881 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-30 02:18:44,052 unpacking tar archive at: mozilla-central-19f368b1267d/testing/mozharness/ program finished with exit code 0 elapsedTime=13.477053 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-09-30 02:18:44.314195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-30 02:18:44.314603) ========= script_repo_revision: 19f368b1267d67f1bc214abae058ec20cb532c64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-30 02:18:44.315049) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-30 02:18:44.315381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-30 02:18:44.330401) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-30 02:18:44.330815) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:18:44 INFO - MultiFileLogger online at 20170930 02:18:44 in /builds/slave/test 02:18:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:18:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:18:44 INFO - {'append_to_log': False, 02:18:44 INFO - 'base_work_dir': '/builds/slave/test', 02:18:44 INFO - 'blob_upload_branch': 'Firefox', 02:18:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:18:44 INFO - 'branch': 'Firefox', 02:18:44 INFO - 'buildbot_json_path': 'buildprops.json', 02:18:44 INFO - 'code_coverage': False, 02:18:44 INFO - 'config_files': ('talos/linux_config.py',), 02:18:44 INFO - 'default_actions': ('clobber', 02:18:44 INFO - 'read-buildbot-config', 02:18:44 INFO - 'download-and-extract', 02:18:44 INFO - 'populate-webroot', 02:18:44 INFO - 'create-virtualenv', 02:18:44 INFO - 'install', 02:18:44 INFO - 'setup-mitmproxy', 02:18:44 INFO - 'run-tests'), 02:18:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:18:44 INFO - 'disable_ccov_upload': False, 02:18:44 INFO - 'disable_stylo': False, 02:18:44 INFO - 'download_minidump_stackwalk': True, 02:18:44 INFO - 'download_symbols': 'ondemand', 02:18:44 INFO - 'enable_stylo': False, 02:18:44 INFO - 'enable_webrender': False, 02:18:44 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:18:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:18:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:18:44 INFO - 'gecko_profile': False, 02:18:44 INFO - 'gecko_profile_interval': 0, 02:18:44 INFO - 'installer_path': 'installer.exe', 02:18:44 INFO - 'log_level': 'info', 02:18:44 INFO - 'log_name': 'talos', 02:18:44 INFO - 'log_to_console': True, 02:18:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:18:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:18:44 INFO - 'opt_config_files': (), 02:18:44 INFO - 'pip_index': False, 02:18:44 INFO - 'suite': 'dromaeojs-e10s', 02:18:44 INFO - 'system_bits': '32', 02:18:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:18:44 INFO - 'title': 'talos-linux64-ix-061', 02:18:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:18:44 INFO - 'use_talos_json': True, 02:18:44 INFO - 'verify': 'False', 02:18:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:18:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:18:44 INFO - 'work_dir': 'build'} 02:18:44 INFO - [mozharness: 2017-09-30 09:18:44.641182Z] Running clobber step. 02:18:44 INFO - Running pre-action listener: _resource_record_pre_action 02:18:44 INFO - Running main action method: clobber 02:18:44 INFO - rmtree: /builds/slave/test/build 02:18:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:18:45 INFO - Running post-action listener: _resource_record_post_action 02:18:45 INFO - [mozharness: 2017-09-30 09:18:45.593609Z] Finished clobber step (success) 02:18:45 INFO - [mozharness: 2017-09-30 09:18:45.593727Z] Running read-buildbot-config step. 02:18:45 INFO - Running pre-action listener: _resource_record_pre_action 02:18:45 INFO - Running main action method: read_buildbot_config 02:18:45 INFO - Using buildbot properties: 02:18:45 INFO - { 02:18:45 INFO - "project": "", 02:18:45 INFO - "product": "firefox", 02:18:45 INFO - "who": "archaeopteryx@coole-files.de", 02:18:45 INFO - "installer_path": "public/build/target.tar.bz2", 02:18:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 02:18:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:18:45 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 02:18:45 INFO - "stage_platform": "linux64-qr", 02:18:45 INFO - "basedir": "/builds/slave/test", 02:18:45 INFO - "buildnumber": 94, 02:18:45 INFO - "platform": "ubuntu64_hw_qr", 02:18:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:18:45 INFO - "slavebuilddir": "test", 02:18:45 INFO - "taskId": "IyqVBgBpSdatj9w26_cvcQ", 02:18:45 INFO - "branch": "mozilla-central", 02:18:45 INFO - "script_repo_revision": "production", 02:18:45 INFO - "revision": "19f368b1267d67f1bc214abae058ec20cb532c64", 02:18:45 INFO - "slavename": "talos-linux64-ix-061", 02:18:45 INFO - "repo_path": "mozilla-central" 02:18:45 INFO - } 02:18:45 INFO - Finding installer, test and symbols from parent task. 02:18:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IyqVBgBpSdatj9w26_cvcQ'}, attempt #1 02:18:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IyqVBgBpSdatj9w26_cvcQ'}, attempt #1 02:18:46 INFO - Task dependencies: b7fo7CzdTyC6sEI3QK7nvA 02:18:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA'}, attempt #1 02:18:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.tar.bz2 02:18:47 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.test_packages.json 02:18:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.crashreporter-symbols.zip 02:18:47 INFO - Running post-action listener: _resource_record_post_action 02:18:47 INFO - [mozharness: 2017-09-30 09:18:47.016676Z] Finished read-buildbot-config step (success) 02:18:47 INFO - [mozharness: 2017-09-30 09:18:47.016897Z] Running download-and-extract step. 02:18:47 INFO - Running pre-action listener: _resource_record_pre_action 02:18:47 INFO - Running main action method: download_and_extract 02:18:47 INFO - mkdir: /builds/slave/test/build/tests 02:18:47 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')]} 02:18:47 INFO - trying https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.test_packages.json 02:18:47 INFO - Downloading https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:18:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:18:47 INFO - Downloaded 989 bytes. 02:18:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:18:47 INFO - Using the following test package requirements: 02:18:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:18:47 INFO - u'common': [u'target.common.tests.zip'], 02:18:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:18:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:18:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:18:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:18:47 INFO - u'mozbase': [u'target.common.tests.zip'], 02:18:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:18:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:18:47 INFO - u'web-platform': [u'target.common.tests.zip', 02:18:47 INFO - u'target.web-platform.tests.tar.gz'], 02:18:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:18:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:18:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.common.tests.zip 02:18:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:18:47 INFO - Fetch https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.common.tests.zip into memory 02:18:48 INFO - Content-Length response header: 55366760 02:18:48 INFO - Bytes received: 55366760 02:18:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.talos.tests.zip 02:18:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:18:59 INFO - Fetch https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.talos.tests.zip into memory 02:19:00 INFO - Content-Length response header: 14522385 02:19:00 INFO - Bytes received: 14522385 02:19: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')]} 02:19:00 INFO - trying https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.tar.bz2 02:19:00 INFO - Downloading https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:19:03 INFO - Downloaded 61622128 bytes. 02:19:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.tar.bz2 02:19:03 INFO - mkdir: /builds/slave/test/properties 02:19:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:19:03 INFO - Writing to file /builds/slave/test/properties/build_url 02:19:03 INFO - Contents: 02:19:03 INFO - build_url:https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.tar.bz2 02:19:03 INFO - Running post-action listener: _resource_record_post_action 02:19:03 INFO - Running post-action listener: find_tests_for_verification 02:19:03 INFO - Running post-action listener: set_extra_try_arguments 02:19:03 INFO - [mozharness: 2017-09-30 09:19:03.185926Z] Finished download-and-extract step (success) 02:19:03 INFO - [mozharness: 2017-09-30 09:19:03.186070Z] Running populate-webroot step. 02:19:03 INFO - Running pre-action listener: _resource_record_pre_action 02:19:03 INFO - Running main action method: populate_webroot 02:19:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:19:03 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:19:03 INFO - 'tests': ['tresize', 02:19:03 INFO - 'tcanvasmark']}, 02:19:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:19:03 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:19:03 INFO - 'tests': ['dromaeo_css', 02:19:03 INFO - 'kraken']}, 02:19:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:19:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:03 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:19:03 INFO - 'talos_options': ['--disable-stylo'], 02:19:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:19:03 INFO - 'tests': ['damp', 'tps']}, 02:19:03 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:19:03 INFO - 'talos_options': ['--disable-stylo'], 02:19:03 INFO - 'tests': ['damp', 'tps']}, 02:19:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:19:03 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:19:03 INFO - 'tests': ['dromaeo_dom']}, 02:19:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:19:03 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:19:03 INFO - 'tests': ['basic_compositor_video', 02:19:03 INFO - 'glvideo']}, 02:19:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:19:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:19:03 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:19:03 INFO - 'talos_options': ['--disable-stylo'], 02:19:03 INFO - 'tests': ['ts_paint_webext', 02:19:03 INFO - 'tp5o_webext']}, 02:19:03 INFO - 'other-e10s': {'tests': ['a11yr', 02:19:03 INFO - 'ts_paint', 02:19:03 INFO - 'tpaint', 02:19:03 INFO - 'sessionrestore', 02:19:03 INFO - 'sessionrestore_many_windows', 02:19:03 INFO - 'sessionrestore_no_auto_restore', 02:19:03 INFO - 'tabpaint', 02:19:03 INFO - 'cpstartup']}, 02:19:03 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:19:03 INFO - 'tests': ['a11yr', 02:19:03 INFO - 'ts_paint', 02:19:03 INFO - 'tpaint', 02:19:03 INFO - 'sessionrestore', 02:19:03 INFO - 'sessionrestore_many_windows', 02:19:03 INFO - 'sessionrestore_no_auto_restore', 02:19:03 INFO - 'tabpaint', 02:19:03 INFO - 'cpstartup']}, 02:19:03 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 02:19:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 02:19:03 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:19:03 INFO - 'tests': ['perf_reftest_singletons']}, 02:19:03 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:19:03 INFO - 'tests': ['perf_reftest']}, 02:19:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:19:03 INFO - 'tsvgr_opacity', 02:19:03 INFO - 'tart', 02:19:03 INFO - 'tscrollx', 02:19:03 INFO - 'tsvg_static']}, 02:19:03 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:19:03 INFO - 'tests': ['tsvgx', 02:19:03 INFO - 'tsvgr_opacity', 02:19:03 INFO - 'tart', 02:19:03 INFO - 'tscrollx', 02:19:03 INFO - 'tsvg_static']}, 02:19:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:19:03 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:19:03 INFO - 'talos_options': ['--disable-stylo'], 02:19:03 INFO - 'tests': ['tp5o']}, 02:19:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:19:03 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 02:19:03 INFO - 'talos_options': ['--mitmproxy', 02:19:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:19:03 INFO - '--firstNonBlankPaint'], 02:19:03 INFO - 'tests': ['tp6_google', 02:19:03 INFO - 'tp6_youtube', 02:19:03 INFO - 'tp6_amazon', 02:19:03 INFO - 'tp6_facebook']}, 02:19:03 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:19:03 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 02:19:03 INFO - 'talos_options': ['--disable-stylo', 02:19:03 INFO - '--mitmproxy', 02:19:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:19:03 INFO - '--firstNonBlankPaint'], 02:19:03 INFO - 'tests': ['tp6_google', 02:19:03 INFO - 'tp6_youtube', 02:19:03 INFO - 'tp6_amazon', 02:19:03 INFO - 'tp6_facebook']}, 02:19:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:19:03 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 02:19:03 INFO - 'talos_options': ['--stylo-threads=1', 02:19:03 INFO - '--mitmproxy', 02:19:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:19:03 INFO - '--firstNonBlankPaint'], 02:19:03 INFO - 'tests': ['tp6_google', 02:19:03 INFO - 'tp6_youtube', 02:19:03 INFO - 'tp6_amazon', 02:19:03 INFO - 'tp6_facebook']}, 02:19:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:19:03 INFO - 'talos_options': ['--xperf_path', 02:19:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:03 INFO - 'tests': ['tp5n']}, 02:19:03 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:19:03 INFO - 'talos_options': ['--disable-stylo', 02:19:03 INFO - '--xperf_path', 02:19:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:03 INFO - 'tests': ['tp5n']}}} 02:19:03 INFO - Running post-action listener: _resource_record_post_action 02:19:03 INFO - [mozharness: 2017-09-30 09:19:03.201829Z] Finished populate-webroot step (success) 02:19:03 INFO - [mozharness: 2017-09-30 09:19:03.201925Z] Running create-virtualenv step. 02:19:03 INFO - Running pre-action listener: _resource_record_pre_action 02:19:03 INFO - Running main action method: create_virtualenv 02:19:03 INFO - Creating virtualenv /builds/slave/test/build/venv 02:19:03 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:19:03 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:19:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:19:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:19:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:19:04 INFO - Installing distribute.............................................................................................................................................................................................done. 02:19:04 INFO - Installing pip...............done. 02:19:04 INFO - Return code: 0 02:19:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:19:04 INFO - Reading from file tmpfile_stdout 02:19:04 INFO - Output received: 02:19:04 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:19:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104440>, '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 0x1105130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff320>, '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': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', '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 02:19:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:19:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:19:04 INFO - Using env: {'DISPLAY': ':0', 02:19:04 INFO - 'HOME': '/home/cltbld', 02:19:04 INFO - 'LANG': 'en_US.UTF-8', 02:19:04 INFO - 'LANGUAGE': 'en_US:en', 02:19:04 INFO - 'LOGNAME': 'cltbld', 02:19:04 INFO - 'MAIL': '/var/mail/cltbld', 02:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:04 INFO - 'MOZ_NO_REMOTE': '1', 02:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:04 INFO - 'NO_EM_RESTART': '1', 02:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:04 INFO - 'PWD': '/builds/slave/test', 02:19:04 INFO - 'SHELL': '/bin/bash', 02:19:04 INFO - 'SHLVL': '1', 02:19:04 INFO - 'TERM': 'linux', 02:19:04 INFO - 'TMOUT': '86400', 02:19:04 INFO - 'USER': 'cltbld', 02:19:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', 02:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:04 INFO - '_': '/tools/buildbot/bin/python'} 02:19:05 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:19:05 INFO - Downloading/unpacking pip>=1.5 02:19:05 INFO - Running setup.py egg_info for package pip 02:19:05 INFO - warning: no files found matching 'pip/cacert.pem' 02:19:05 INFO - warning: no files found matching '*.html' under directory 'docs' 02:19:05 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:19:05 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:19:05 INFO - Installing collected packages: pip 02:19:05 INFO - Found existing installation: pip 1.1 02:19:05 INFO - Uninstalling pip: 02:19:05 INFO - Successfully uninstalled pip 02:19:05 INFO - Running setup.py install for pip 02:19:05 INFO - warning: no files found matching 'pip/cacert.pem' 02:19:05 INFO - warning: no files found matching '*.html' under directory 'docs' 02:19:05 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:19:05 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:19:05 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:19:05 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:19:05 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:19:05 INFO - Successfully installed pip 02:19:05 INFO - Cleaning up... 02:19:05 INFO - Return code: 0 02:19:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:05 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 0xd951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104440>, '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 0x1105130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff320>, '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': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', '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 02:19:05 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 02:19:05 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 02:19:05 INFO - Using env: {'DISPLAY': ':0', 02:19:05 INFO - 'HOME': '/home/cltbld', 02:19:05 INFO - 'LANG': 'en_US.UTF-8', 02:19:05 INFO - 'LANGUAGE': 'en_US:en', 02:19:05 INFO - 'LOGNAME': 'cltbld', 02:19:05 INFO - 'MAIL': '/var/mail/cltbld', 02:19:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:05 INFO - 'MOZ_NO_REMOTE': '1', 02:19:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:05 INFO - 'NO_EM_RESTART': '1', 02:19:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:05 INFO - 'PWD': '/builds/slave/test', 02:19:05 INFO - 'SHELL': '/bin/bash', 02:19:05 INFO - 'SHLVL': '1', 02:19:05 INFO - 'TERM': 'linux', 02:19:05 INFO - 'TMOUT': '86400', 02:19:05 INFO - 'USER': 'cltbld', 02:19:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', 02:19:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:05 INFO - '_': '/tools/buildbot/bin/python'} 02:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:06 INFO - Downloading/unpacking psutil>=3.1.1 02:19:06 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 02:19:06 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 02:19:06 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 02:19:06 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 02:19:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:19:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:07 INFO - Installing collected packages: psutil 02:19:07 INFO - Running setup.py install for psutil 02:19:07 INFO - building 'psutil._psutil_linux' extension 02:19:07 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 02:19:08 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 02:19:08 INFO - building 'psutil._psutil_posix' extension 02:19:08 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 02:19:08 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 02:19:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:19:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:19:08 INFO - Successfully installed psutil 02:19:08 INFO - Cleaning up... 02:19:08 INFO - Return code: 0 02:19:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:08 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 0xd951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104440>, '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 0x1105130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff320>, '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': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', '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 02:19:08 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 02:19:08 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 02:19:08 INFO - Using env: {'DISPLAY': ':0', 02:19:08 INFO - 'HOME': '/home/cltbld', 02:19:08 INFO - 'LANG': 'en_US.UTF-8', 02:19:08 INFO - 'LANGUAGE': 'en_US:en', 02:19:08 INFO - 'LOGNAME': 'cltbld', 02:19:08 INFO - 'MAIL': '/var/mail/cltbld', 02:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:08 INFO - 'MOZ_NO_REMOTE': '1', 02:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:08 INFO - 'NO_EM_RESTART': '1', 02:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:08 INFO - 'PWD': '/builds/slave/test', 02:19:08 INFO - 'SHELL': '/bin/bash', 02:19:08 INFO - 'SHLVL': '1', 02:19:08 INFO - 'TERM': 'linux', 02:19:08 INFO - 'TMOUT': '86400', 02:19:08 INFO - 'USER': 'cltbld', 02:19:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', 02:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:08 INFO - '_': '/tools/buildbot/bin/python'} 02:19:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:19:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:19:10 INFO - Installing collected packages: mozsystemmonitor 02:19:10 INFO - Running setup.py install for mozsystemmonitor 02:19:10 INFO - Successfully installed mozsystemmonitor 02:19:10 INFO - Cleaning up... 02:19:10 INFO - Return code: 0 02:19:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:10 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 0xd951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104440>, '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 0x1105130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff320>, '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': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', '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 02:19:10 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 02:19:10 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 02:19:10 INFO - Using env: {'DISPLAY': ':0', 02:19:10 INFO - 'HOME': '/home/cltbld', 02:19:10 INFO - 'LANG': 'en_US.UTF-8', 02:19:10 INFO - 'LANGUAGE': 'en_US:en', 02:19:10 INFO - 'LOGNAME': 'cltbld', 02:19:10 INFO - 'MAIL': '/var/mail/cltbld', 02:19:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:10 INFO - 'MOZ_NO_REMOTE': '1', 02:19:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:10 INFO - 'NO_EM_RESTART': '1', 02:19:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:10 INFO - 'PWD': '/builds/slave/test', 02:19:10 INFO - 'SHELL': '/bin/bash', 02:19:10 INFO - 'SHLVL': '1', 02:19:10 INFO - 'TERM': 'linux', 02:19:10 INFO - 'TMOUT': '86400', 02:19:10 INFO - 'USER': 'cltbld', 02:19:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', 02:19:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:10 INFO - '_': '/tools/buildbot/bin/python'} 02:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:10 INFO - Downloading/unpacking jsonschema==2.5.1 02:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:19:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:19:11 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 02:19:11 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 02:19:11 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 02:19:11 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 02:19:11 INFO - Downloading functools32-3.2.3-2.tar.gz 02:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:19:11 INFO - warning: no files found matching '*.txt' 02:19:11 INFO - no previously-included directories found matching 'build' 02:19:11 INFO - no previously-included directories found matching 'dist' 02:19:11 INFO - no previously-included directories found matching '.git*' 02:19:11 INFO - Installing collected packages: jsonschema, functools32 02:19:11 INFO - Running setup.py install for functools32 02:19:11 INFO - warning: no files found matching '*.txt' 02:19:11 INFO - no previously-included directories found matching 'build' 02:19:11 INFO - no previously-included directories found matching 'dist' 02:19:11 INFO - no previously-included directories found matching '.git*' 02:19:11 INFO - Successfully installed jsonschema functools32 02:19:11 INFO - Cleaning up... 02:19:12 INFO - Return code: 0 02:19:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:12 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 0xd951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104440>, '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 0x1105130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff320>, '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': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', '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 02:19:12 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 02:19:12 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 02:19:12 INFO - Using env: {'DISPLAY': ':0', 02:19:12 INFO - 'HOME': '/home/cltbld', 02:19:12 INFO - 'LANG': 'en_US.UTF-8', 02:19:12 INFO - 'LANGUAGE': 'en_US:en', 02:19:12 INFO - 'LOGNAME': 'cltbld', 02:19:12 INFO - 'MAIL': '/var/mail/cltbld', 02:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:12 INFO - 'MOZ_NO_REMOTE': '1', 02:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:12 INFO - 'NO_EM_RESTART': '1', 02:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:12 INFO - 'PWD': '/builds/slave/test', 02:19:12 INFO - 'SHELL': '/bin/bash', 02:19:12 INFO - 'SHLVL': '1', 02:19:12 INFO - 'TERM': 'linux', 02:19:12 INFO - 'TMOUT': '86400', 02:19:12 INFO - 'USER': 'cltbld', 02:19:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', 02:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:12 INFO - '_': '/tools/buildbot/bin/python'} 02:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:19:12 INFO - Cleaning up... 02:19:12 INFO - Return code: 0 02:19:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:12 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 0xd951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104440>, '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 0x1105130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff320>, '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': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', '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 02:19:12 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 02:19:12 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 02:19:12 INFO - Using env: {'DISPLAY': ':0', 02:19:12 INFO - 'HOME': '/home/cltbld', 02:19:12 INFO - 'LANG': 'en_US.UTF-8', 02:19:12 INFO - 'LANGUAGE': 'en_US:en', 02:19:12 INFO - 'LOGNAME': 'cltbld', 02:19:12 INFO - 'MAIL': '/var/mail/cltbld', 02:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:12 INFO - 'MOZ_NO_REMOTE': '1', 02:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:12 INFO - 'NO_EM_RESTART': '1', 02:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:12 INFO - 'PWD': '/builds/slave/test', 02:19:12 INFO - 'SHELL': '/bin/bash', 02:19:12 INFO - 'SHLVL': '1', 02:19:12 INFO - 'TERM': 'linux', 02:19:12 INFO - 'TMOUT': '86400', 02:19:12 INFO - 'USER': 'cltbld', 02:19:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', 02:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:12 INFO - '_': '/tools/buildbot/bin/python'} 02:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:12 INFO - Downloading/unpacking blobuploader==1.2.4 02:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:19:13 INFO - Downloading blobuploader-1.2.4.tar.gz 02:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:19:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:19:13 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 02:19:13 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 02:19:13 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 02:19:13 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 02:19:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:19:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:19:13 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 02:19:13 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 02:19:13 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 02:19:13 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 02:19:14 INFO - Downloading docopt-0.6.1.tar.gz 02:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:19:14 INFO - Installing collected packages: blobuploader, requests, docopt 02:19:14 INFO - Running setup.py install for blobuploader 02:19:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:19:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:19:14 INFO - Running setup.py install for requests 02:19:14 INFO - Running setup.py install for docopt 02:19:14 INFO - Successfully installed blobuploader requests docopt 02:19:14 INFO - Cleaning up... 02:19:14 INFO - Return code: 0 02:19:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:14 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 0xd951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104440>, '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 0x1105130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff320>, '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': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', '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 02:19:14 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 02:19:14 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 02:19:14 INFO - Using env: {'DISPLAY': ':0', 02:19:14 INFO - 'HOME': '/home/cltbld', 02:19:14 INFO - 'LANG': 'en_US.UTF-8', 02:19:14 INFO - 'LANGUAGE': 'en_US:en', 02:19:14 INFO - 'LOGNAME': 'cltbld', 02:19:14 INFO - 'MAIL': '/var/mail/cltbld', 02:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:14 INFO - 'MOZ_NO_REMOTE': '1', 02:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:14 INFO - 'NO_EM_RESTART': '1', 02:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:14 INFO - 'PWD': '/builds/slave/test', 02:19:14 INFO - 'SHELL': '/bin/bash', 02:19:14 INFO - 'SHLVL': '1', 02:19:14 INFO - 'TERM': 'linux', 02:19:14 INFO - 'TMOUT': '86400', 02:19:14 INFO - 'USER': 'cltbld', 02:19:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', 02:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:14 INFO - '_': '/tools/buildbot/bin/python'} 02:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:14 INFO - Running setup.py (path:/tmp/pip-rzJdui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:15 INFO - Running setup.py (path:/tmp/pip-jyU5Vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:15 INFO - Running setup.py (path:/tmp/pip-Qjcd9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:15 INFO - Running setup.py (path:/tmp/pip-Be24O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:15 INFO - Running setup.py (path:/tmp/pip-XDk2kO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:15 INFO - Running setup.py (path:/tmp/pip-nUFjdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:15 INFO - Running setup.py (path:/tmp/pip-JJW3nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:15 INFO - Running setup.py (path:/tmp/pip-fxM_a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:15 INFO - Running setup.py (path:/tmp/pip-Xe_OsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:15 INFO - Running setup.py (path:/tmp/pip-Mz_Zjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:15 INFO - Running setup.py (path:/tmp/pip-kJe1g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:15 INFO - Running setup.py (path:/tmp/pip-mu6sMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:15 INFO - Running setup.py (path:/tmp/pip-rVV6Zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:15 INFO - Running setup.py (path:/tmp/pip-nCiH6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:15 INFO - Running setup.py (path:/tmp/pip-Nol5pX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:16 INFO - Running setup.py (path:/tmp/pip-OR_twE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:16 INFO - Running setup.py (path:/tmp/pip-58IS84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:19:16 INFO - Running setup.py install for manifestparser 02:19:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Running setup.py install for mozcrash 02:19:16 INFO - Running setup.py install for mozdebug 02:19:16 INFO - Running setup.py install for mozdevice 02:19:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Running setup.py install for mozfile 02:19:16 INFO - Running setup.py install for mozhttpd 02:19:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Running setup.py install for mozinfo 02:19:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Running setup.py install for mozInstall 02:19:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:19:16 INFO - Running setup.py install for mozleak 02:19:17 INFO - Running setup.py install for mozlog 02:19:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Running setup.py install for moznetwork 02:19:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Running setup.py install for mozprocess 02:19:17 INFO - Running setup.py install for mozprofile 02:19:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Running setup.py install for mozrunner 02:19:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Running setup.py install for mozscreenshot 02:19:17 INFO - Running setup.py install for moztest 02:19:17 INFO - Running setup.py install for mozversion 02:19:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:19:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:19:17 INFO - Cleaning up... 02:19:17 INFO - Return code: 0 02:19:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19:17 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')]} 02:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:17 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')]} 02:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:17 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 0xd951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104440>, '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 0x1105130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff320>, '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': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', '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 02:19:17 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 02:19:17 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 02:19:17 INFO - Using env: {'DISPLAY': ':0', 02:19:17 INFO - 'HOME': '/home/cltbld', 02:19:17 INFO - 'LANG': 'en_US.UTF-8', 02:19:17 INFO - 'LANGUAGE': 'en_US:en', 02:19:17 INFO - 'LOGNAME': 'cltbld', 02:19:17 INFO - 'MAIL': '/var/mail/cltbld', 02:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:17 INFO - 'MOZ_NO_REMOTE': '1', 02:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:17 INFO - 'NO_EM_RESTART': '1', 02:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:17 INFO - 'PWD': '/builds/slave/test', 02:19:17 INFO - 'SHELL': '/bin/bash', 02:19:17 INFO - 'SHLVL': '1', 02:19:17 INFO - 'TERM': 'linux', 02:19:17 INFO - 'TMOUT': '86400', 02:19:17 INFO - 'USER': 'cltbld', 02:19:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', 02:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:17 INFO - '_': '/tools/buildbot/bin/python'} 02:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:19:18 INFO - Running setup.py (path:/tmp/pip-3OqnnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:19:18 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)) 02:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:19:18 INFO - Running setup.py (path:/tmp/pip-BLrKKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:19:18 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)) 02:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:19:18 INFO - Running setup.py (path:/tmp/pip-auwi8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:19:18 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)) 02:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:19:18 INFO - Running setup.py (path:/tmp/pip-94C4By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:19:18 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)) 02:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:19:18 INFO - Running setup.py (path:/tmp/pip-Ufil5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:19:18 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)) 02:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:19:18 INFO - Running setup.py (path:/tmp/pip-MvkrSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:19:18 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)) 02:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:19:18 INFO - Running setup.py (path:/tmp/pip-zTYo3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:19:18 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)) 02:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:19:18 INFO - Running setup.py (path:/tmp/pip-h9Q0KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:19:18 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)) 02:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:19:18 INFO - Running setup.py (path:/tmp/pip-ZVFXZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:19:18 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)) 02:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:19:18 INFO - Running setup.py (path:/tmp/pip-d2HQim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:19:18 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)) 02:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:19:18 INFO - Running setup.py (path:/tmp/pip-etBnB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:19:18 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)) 02:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:19:18 INFO - Running setup.py (path:/tmp/pip-6CSz9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:19:19 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)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:19:19 INFO - Running setup.py (path:/tmp/pip-Ji3m4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:19:19 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)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:19:19 INFO - Running setup.py (path:/tmp/pip-OTA1Q4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:19:19 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)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:19 INFO - Running setup.py (path:/tmp/pip-M2eBqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:19:19 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)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:19:19 INFO - Running setup.py (path:/tmp/pip-CV1s6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:19:19 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)) 02:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:19:19 INFO - Running setup.py (path:/tmp/pip-dSMrS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:19:19 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)) 02:19:19 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)) 02:19:19 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)) 02:19:19 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)) 02:19:19 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)) 02:19:19 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)) 02:19:19 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)) 02:19:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:19:19 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 02:19:19 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 02:19:19 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 02:19:19 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 02:19:20 INFO - Downloading blessings-1.6.tar.gz 02:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:19:20 INFO - Installing collected packages: blessings 02:19:20 INFO - Running setup.py install for blessings 02:19:20 INFO - Successfully installed blessings 02:19:20 INFO - Cleaning up... 02:19:20 INFO - Return code: 0 02:19:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:19:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:19:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:19:20 INFO - Reading from file tmpfile_stdout 02:19:20 INFO - Current package versions: 02:19:20 INFO - argparse == 1.2.1 02:19:20 INFO - blessings == 1.6 02:19:20 INFO - blobuploader == 1.2.4 02:19:20 INFO - docopt == 0.6.1 02:19:20 INFO - functools32 == 3.2.3-2 02:19:20 INFO - jsonschema == 2.5.1 02:19:20 INFO - manifestparser == 1.1 02:19:20 INFO - mozInstall == 1.13 02:19:20 INFO - mozcrash == 1.0 02:19:20 INFO - mozdebug == 0.1 02:19:20 INFO - mozdevice == 0.51 02:19:20 INFO - mozfile == 1.2 02:19:20 INFO - mozhttpd == 0.7 02:19:20 INFO - mozinfo == 0.10 02:19:20 INFO - mozleak == 0.1 02:19:20 INFO - mozlog == 3.5 02:19:20 INFO - moznetwork == 0.27 02:19:20 INFO - mozprocess == 0.25 02:19:20 INFO - mozprofile == 0.28 02:19:20 INFO - mozrunner == 6.13 02:19:20 INFO - mozscreenshot == 0.1 02:19:20 INFO - mozsystemmonitor == 0.3 02:19:20 INFO - moztest == 0.8 02:19:20 INFO - mozversion == 1.4 02:19:20 INFO - psutil == 3.1.1 02:19:20 INFO - requests == 1.2.3 02:19:20 INFO - wsgiref == 0.1.2 02:19:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:19: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')]} 02:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19: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')]} 02:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:21 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 0xd951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104440>, '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 0x1105130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff320>, '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': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', '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 02:19:21 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 02:19:21 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 02:19:21 INFO - Using env: {'DISPLAY': ':0', 02:19:21 INFO - 'HOME': '/home/cltbld', 02:19:21 INFO - 'LANG': 'en_US.UTF-8', 02:19:21 INFO - 'LANGUAGE': 'en_US:en', 02:19:21 INFO - 'LOGNAME': 'cltbld', 02:19:21 INFO - 'MAIL': '/var/mail/cltbld', 02:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:21 INFO - 'MOZ_NO_REMOTE': '1', 02:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:21 INFO - 'NO_EM_RESTART': '1', 02:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:21 INFO - 'PWD': '/builds/slave/test', 02:19:21 INFO - 'SHELL': '/bin/bash', 02:19:21 INFO - 'SHLVL': '1', 02:19:21 INFO - 'TERM': 'linux', 02:19:21 INFO - 'TMOUT': '86400', 02:19:21 INFO - 'USER': 'cltbld', 02:19:21 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', 02:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:21 INFO - '_': '/tools/buildbot/bin/python'} 02:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:21 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)) 02:19:21 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)) 02:19:21 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)) 02:19:21 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)) 02:19:21 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)) 02:19:21 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)) 02:19:21 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)) 02:19:21 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)) 02:19:21 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)) 02:19:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:19:21 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 02:19:21 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 02:19:21 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 02:19:21 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 02:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:19:22 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)) 02:19:22 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)) 02:19:22 INFO - Installing collected packages: simplejson 02:19:22 INFO - Running setup.py install for simplejson 02:19:22 INFO - building 'simplejson._speedups' extension 02:19:22 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 02:19:23 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 02:19:23 INFO - Successfully installed simplejson 02:19:23 INFO - Cleaning up... 02:19:23 INFO - Return code: 0 02:19:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:19:23 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')]} 02:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:23 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')]} 02:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:23 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 0xd951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5db70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100df0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104440>, '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 0x1105130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff320>, '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': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', '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 02:19:23 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 02:19:23 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 02:19:23 INFO - Using env: {'DISPLAY': ':0', 02:19:23 INFO - 'HOME': '/home/cltbld', 02:19:23 INFO - 'LANG': 'en_US.UTF-8', 02:19:23 INFO - 'LANGUAGE': 'en_US:en', 02:19:23 INFO - 'LOGNAME': 'cltbld', 02:19:23 INFO - 'MAIL': '/var/mail/cltbld', 02:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:23 INFO - 'MOZ_NO_REMOTE': '1', 02:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:23 INFO - 'NO_EM_RESTART': '1', 02:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:23 INFO - 'PWD': '/builds/slave/test', 02:19:23 INFO - 'SHELL': '/bin/bash', 02:19:23 INFO - 'SHLVL': '1', 02:19:23 INFO - 'TERM': 'linux', 02:19:23 INFO - 'TMOUT': '86400', 02:19:23 INFO - 'USER': 'cltbld', 02:19:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', 02:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:23 INFO - '_': '/tools/buildbot/bin/python'} 02:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:19:23 INFO - Cleaning up... 02:19:23 INFO - Return code: 0 02:19:23 INFO - Running post-action listener: _resource_record_post_action 02:19:23 INFO - Running post-action listener: _start_resource_monitoring 02:19:23 INFO - Starting resource monitoring. 02:19:23 INFO - [mozharness: 2017-09-30 09:19:23.756935Z] Finished create-virtualenv step (success) 02:19:23 INFO - [mozharness: 2017-09-30 09:19:23.757450Z] Running install step. 02:19:23 INFO - Running pre-action listener: _resource_record_pre_action 02:19:23 INFO - Running main action method: install 02:19:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:19:23 INFO - Reading from file tmpfile_stdout 02:19:23 INFO - Detecting whether we're running mozinstall >=1.0... 02:19:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:19:24 INFO - Reading from file tmpfile_stdout 02:19:24 INFO - Output received: 02:19:24 INFO - Usage: mozinstall [options] installer 02:19:24 INFO - Options: 02:19:24 INFO - -h, --help show this help message and exit 02:19:24 INFO - -d DEST, --destination=DEST 02:19:24 INFO - Directory to install application into. [default: 02:19:24 INFO - "/builds/slave/test"] 02:19:24 INFO - --app=APP Application being installed. [default: firefox] 02:19:24 INFO - mkdir: /builds/slave/test/build/application 02:19:24 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'] 02:19:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:19:41 INFO - Reading from file tmpfile_stdout 02:19:41 INFO - Output received: 02:19:41 INFO - /builds/slave/test/build/application/firefox/firefox 02:19:41 INFO - Running post-action listener: _resource_record_post_action 02:19:41 INFO - [mozharness: 2017-09-30 09:19:41.913835Z] Finished install step (success) 02:19:41 INFO - [mozharness: 2017-09-30 09:19:41.914005Z] Running setup-mitmproxy step. 02:19:41 INFO - Running pre-action listener: _resource_record_pre_action 02:19:41 INFO - Running main action method: setup_mitmproxy 02:19:41 INFO - Skipping: mitmproxy is not required 02:19:41 INFO - Running post-action listener: _resource_record_post_action 02:19:41 INFO - [mozharness: 2017-09-30 09:19:41.914486Z] Finished setup-mitmproxy step (success) 02:19:41 INFO - [mozharness: 2017-09-30 09:19:41.914577Z] Running run-tests step. 02:19:41 INFO - Running pre-action listener: _resource_record_pre_action 02:19:41 INFO - Running pre-action listener: _set_gcov_prefix 02:19:41 INFO - Running main action method: run_tests 02:19:41 WARNING - Try message not found. 02:19:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:19:41 INFO - Python 2.7.3 02:19:41 INFO - Return code: 0 02:19:41 INFO - grabbing minidump binary from tooltool 02:19: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')]} 02:19:41 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 0x1104440>, '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 0x1105130>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff320>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:19:41 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 02:19:41 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 02:19:41 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 02:19:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:19:42 INFO - Return code: 0 02:19:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:19:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:19:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:19:42 INFO - ENV: RUST_BACKTRACE is now full 02:19:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:19:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:19:42 INFO - Using env: {'DISPLAY': ':0', 02:19:42 INFO - 'HOME': '/home/cltbld', 02:19:42 INFO - 'LANG': 'en_US.UTF-8', 02:19:42 INFO - 'LANGUAGE': 'en_US:en', 02:19:42 INFO - 'LOGNAME': 'cltbld', 02:19:42 INFO - 'MAIL': '/var/mail/cltbld', 02:19:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:19:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:19:42 INFO - 'MOZ_ACCELERATED': '1', 02:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:42 INFO - 'MOZ_NO_REMOTE': '1', 02:19:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:19:42 INFO - 'MOZ_WEBRENDER': '1', 02:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:42 INFO - 'NO_EM_RESTART': '1', 02:19:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:42 INFO - 'PWD': '/builds/slave/test', 02:19:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:19:42 INFO - 'RUST_BACKTRACE': 'full', 02:19:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:19:42 INFO - 'SHELL': '/bin/bash', 02:19:42 INFO - 'SHLVL': '1', 02:19:42 INFO - 'TERM': 'linux', 02:19:42 INFO - 'TMOUT': '86400', 02:19:42 INFO - 'USER': 'cltbld', 02:19:42 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', 02:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:42 INFO - '_': '/tools/buildbot/bin/python'} 02:19:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:19:42 INFO - mozversion application_buildid: 20170930082206 02:19:42 INFO - mozversion application_changeset: 19f368b1267d67f1bc214abae058ec20cb532c64 02:19:42 INFO - mozversion application_display_name: Nightly 02:19:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:19:42 INFO - mozversion application_name: Firefox 02:19:42 INFO - mozversion application_remotingname: firefox 02:19:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:19:42 INFO - mozversion application_vendor: Mozilla 02:19:42 INFO - mozversion application_version: 58.0a1 02:19:42 INFO - mozversion platform_buildid: 20170930082206 02:19:42 INFO - mozversion platform_changeset: 19f368b1267d67f1bc214abae058ec20cb532c64 02:19:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:19:42 INFO - mozversion platform_version: 58.0a1 02:19:42 INFO - using testdate: 1506763182 02:19:42 INFO - actual date: 1506763182 02:19:42 INFO - starting webserver on 'localhost:38550' 02:19:42 INFO - SUITE-START | Running 2 tests 02:19:42 INFO - TEST-START | dromaeo_css 02:19:42 INFO - Initialising browser for dromaeo_css test... 02:19:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38550/getInfo.html -profile /tmp/tmpmjbYal/profile 02:19:42 INFO - TEST-INFO | started process 3886 (/builds/slave/test/build/application/firefox/firefox http://localhost:38550/getInfo.html) 02:19:50 INFO - TEST-INFO | 3886: exit 0 02:19:51 INFO - Browser initialized. 02:19:51 INFO - Running cycle 1/1 for dromaeo_css test... 02:19:51 INFO - Using env: {'DISPLAY': ':0', 02:19:51 INFO - 'HOME': '/home/cltbld', 02:19:51 INFO - 'JSGC_DISABLE_POISONING': '1', 02:19:51 INFO - 'LANG': 'en_US.UTF-8', 02:19:51 INFO - 'LANGUAGE': 'en_US:en', 02:19:51 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:19:51 INFO - 'LOGNAME': 'cltbld', 02:19:51 INFO - 'MAIL': '/var/mail/cltbld', 02:19:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:19:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:19:51 INFO - 'MOZ_ACCELERATED': '1', 02:19:51 INFO - 'MOZ_CRASHREPORTER': '1', 02:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:51 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:19:51 INFO - 'MOZ_NO_REMOTE': '1', 02:19:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:19:51 INFO - 'MOZ_WEBRENDER': '1', 02:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:19:51 INFO - 'NO_EM_RESTART': '1', 02:19:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:51 INFO - 'PWD': '/builds/slave/test', 02:19:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:19:51 INFO - 'RUST_BACKTRACE': 'full', 02:19:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:19:51 INFO - 'SHELL': '/bin/bash', 02:19:51 INFO - 'SHLVL': '1', 02:19:51 INFO - 'TERM': 'linux', 02:19:51 INFO - 'TMOUT': '86400', 02:19:51 INFO - 'USER': 'cltbld', 02:19:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', 02:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:51 INFO - '_': '/tools/buildbot/bin/python'} 02:19:51 INFO - TEST-INFO | started process 4131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmjbYal/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:19:51 INFO - PID 4131 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:19:51 INFO - PID 4131 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:19:52 INFO - PID 4131 | 02:19:52 INFO - PID 4131 | (/builds/slave/test/build/application/firefox/firefox:4190): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:19:52 INFO - PID 4131 | 02:20:02 INFO - PID 4131 | RSS: Main: 188080128 02:20:02 INFO - PID 4131 | 02:23:00 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:38550/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38550/tests/dromaeo/cssquery-ext.html) 02:23:01 INFO - PID 4131 | RSS: Main: 183148544 02:23:01 INFO - PID 4131 | 02:26:04 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:38550/tests/dromaeo/cssquery-ext.html (next: http://localhost:38550/tests/dromaeo/cssquery-jquery.html) 02:26:04 INFO - PID 4131 | RSS: Main: 181485568 02:26:04 INFO - PID 4131 | 02:29:06 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:38550/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38550/tests/dromaeo/cssquery-mootools.html) 02:29:07 INFO - PID 4131 | RSS: Main: 183455744 02:29:07 INFO - PID 4131 | 02:32:09 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:38550/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38550/tests/dromaeo/cssquery-prototype.html) 02:32:09 INFO - PID 4131 | RSS: Main: 183132160 02:32:09 INFO - PID 4131 | 02:35:13 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:38550/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38550/tests/dromaeo/cssquery-yui.html) 02:35:14 INFO - PID 4131 | RSS: Main: 186589184 02:35:14 INFO - PID 4131 | 02:38:16 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:38550/tests/dromaeo/cssquery-yui.html (next: http://localhost:38550/tests/dromaeo/cssquery-dojo.html) 02:38:16 INFO - PID 4131 | RSS: Main: 187252736 02:38:16 INFO - PID 4131 | 02:38:16 INFO - PID 4131 | __start_tp_report 02:38:16 INFO - PID 4131 | _x_x_mozilla_page_load 02:38:16 INFO - PID 4131 | _x_x_mozilla_page_load_details 02:38:16 INFO - PID 4131 | |i|pagename|runs| 02:38:16 INFO - PID 4131 | |0;dojo.html;3129.499280115182;3150.4014237294914;3166.683331666832;3172.254520187756;3176.9523457148134;6050.334463209049;6070.696465176746;6118.755249790003;6179.752809887605;6183.474404675608;6135.81592552223;6185.319614842364;6220.409061139185;6243.344448832864;6278.121063051165;5670.206171136044;5673.602847800656;5691.117876729103;5720.1991721158865;5732.197492351074;5647.463490968372;5647.689377084259;5707.229524014247;5711.400302968191;5749.080147176453;5641.153826925974;5669.8582535436535;5690.2887139107615;5698.715064246771;5769.134629805541;5536.612437129403;5715.428457154293;5743.655380677131;5769.336526299488;5771.538276937835;5605.131204663284;5621.522170615503;5627.6904770237625;5718;5752.165935939307;6146.7541298348015;6197.81406557804;6225.28409232935;6275.780347687854;6280.748770049193;6525.869482610368;6602.471802255856;6627.105340778981;6680.331966803329;6689.665516724144;6734.124563806723;6740.258571557125;6774.932250677529;6782.5252232343755;6826.385625293748;6170.228721409824;6182.783602573933;6242.906356404657;6296.244450665904;6307.306196318401;6855.828604284833;6867;6884.552504087218;6940.757073502403;6954.3045695431065;6456.12842266288;6461.030845373231;6465.77369792055;6550.639714815731;6701.731930722814;6519.934800651933;6542.869142617121;6554.3117972613145;6565.376289252514;6634.40290373859;6543.934560654333;6586.538942274091;6604.009398590154;6741.831454213586;6751;6715.160604924385;6734.629595372302;6808.7276508939085;6813.761518346834;6813.897791533131;5226.398964119099;5260.92108618371;5263.34208223972;5264.394594621591;5286.127788914863;4482.610390778869;4500.549945005539;4510.503844577094;4553.749543775058;4640.512746161672;5788.479036886701;5823.417658234227;5823.88352232953;5844.15259787337;5845.210896528914;6778.525503214826;6789.422899053537;6793.490488213404;6808.455323574102;6814.965925170342;5779.8555036124435;5785.71071446426;5867.471927526458;5872.11918212263;5875.030619947746;5566.471185237396;5689.886202275931;5709.371969083398;5718.828435146952;5827.650340979555;6437.388448097423;6492.058651495507;6533;6573.112629795012;6580.76967306142;6709.161354830646;6755.86488270222;6766.391024807791;6790.830229244309;6794.8641027180165;6510.21877374718;6526.967365163144;6590.406863382319;6611;6628.138342015507;6396.072569477306;6502.187226596676;6584;6620.801375958729;6728.663566821737;6644.368784965421;6673.699683514351;6686.83282917931;6688.398044176048;6695.531312808057;6338.492920566251;6383.361663833765;6442.35576442352;6532.118164047983;6566.409023187936;6426.710798014007;6441.935580644321;6453.225612926479;6502.707378168088;6515.218173819172;6318.526110541636;6348.269948955929;6419.711112999833;6443.838904027437;6444.065610486547;6338.049292606146;6455.999320105391;6488;6493.935060649522;6515.837104072436;6171.074338849208;6249.500039996698;6250.06249062626;6269.216347956505;6273.341299163522 02:38:16 INFO - PID 4131 | |1;ext.html;871.0984131423976;899.2715900120901;904.6155383961815;909.4225167018949;910.1808372464781;38664;39814.80092599537;42519.14961700764;42607;43013.78493107538;39241.41137882927;39342.21315573694;39627.40558891619;39813.800930995305;39831.800840995755;7174.497785155041;7324.560526368408;7339.376153026999;7342.045534080562;7364.042674452314;7870.212978702112;8065.1934806519175;8073.313768329699;8084.555349455778;8089.191080891923;8101.230383113624;8107.837843243132;8109.797255068641;8114.715984940528;8160.918390816075;7869.016372953381;8013.799655008613;8075.636596353178;8075.798105047392;8078.636461359253;7911.485753426009;7952.045754509438;8001.759947201535;8005.799855003614;8008.039035315741;37741.62258377436;37905.431418528744;38347.041323967125;38581.614183858364;38712.22575548473;3520.3135388599235;3541.8052007139595;3545.9113522161892;3603.3333833240936;3619.6561326673923;31071.533926991113;31150.688493115005;31525;31531;31633.05100846978;5093.083245015896;5151.124308867464;5198.4801519847715;5210.583153347723;5261.815836445706;181764;182362;182790;183166;183205;41682;41773.79113104415;46604;46645.76677116593;46859.5314046862;43828.780856095516;49818;50132;50319;51023.234651480256;14892.553223403314;14945.551633451014;15028.774568381483;15050.397984080515;15075.472358467401;12036.217645852992;12048.87951120495;12076.516939322504;12128.939355303168;12135.453904574315;13490;13665.658358541115;13802.102863314054;13819.792703109462;14007.229602371763;5687.431256874363;5719.571032172604;5723.313202415737;5783.7397317119985;5795.217645617872;974.2644303550916;985.9654912078042;988.6539711101057;1002.0880998291519;1015.9593616255268;22417.88791056067;22511.549769004527;22526.324210273717;22591.661125082806;23038.424039398815;1095.5782023920688;1107.3521989636154;1108.2187058124002;1110.0509064749683;1110.245033377295;12223.877761222275;12285;12286.75426491465;12347.196817495762;12367.567135150226;227521;228466;228634;229736;229846;52862.47137528652;53114.203286950724;53615.463845361824;53764.73117634387;53814.19278710822;1410.2737090398452;1439.9568012959628;1447.232966527742;1447.486142419447;1449.9202543859979;22043.559128817655;22154.22460213885;22169.77830221677;22555.323340299816;22759.772402275765;35364.46953295754;35765.82117089398;35775.82112089423;35821;35836.82081589576;198075;199715;199817;201111;201502;27842.58236126419;29664;30043;30233.848830755705;32452;36460.45309320309;40557.18885622212;40611;40861.795691021354;41193.794031030855;29785.404291913608;29796;30040.549391759578;30249.848750756104;30664;29152.708472915;29190.70809291965;29448.263793405335;29553.85223073871;30259.69740302569;32297.192570185933;33133;33173.50239746454;33480.497792532646;33892.661073388954;28721;29328.560071598517;29446;29634.407311854073;30112.24719382033;22279.77720222777;22345.888270558542;22652.660210096532;22693.43266418353;22839.54320913539 02:38:16 INFO - PID 4131 | |2;jquery.html;560.9074502707053;571.5620542437243;584;596.3559355895633;605.6668832142321;21226.89386553067;21940.232091876787;21964.670529942025;21994.45013874654;22027.449313767163;23938.16216432425;24294.11442540838;24417.75582244177;25443.109491167812;25572;6479.481641468683;6544.411003009728;6603.603783772965;6620.470362370998;6654.600723956578;6539.836504087389;6614.669266536654;6631.071649969008;6635.469162466991;6638.1370421845095;6441.227052753676;6679;6689.665516724169;6705.295943925891;6717.126773519436;6618.106555614979;6644;6715.630640314781;6724.663766811665;6729.360710732472;5988.461038506512;6119.296280927661;6230.096635987802;6260.09228661846;6267.71795269214;28845.71154288472;29358.559621605695;29458.263543411373;29523.55714664282;29558.408831823457;2004.5589970206531;2031.9593608127902;2035.5827055453597;2044.4582185720647;2049.4876280929766;19209.711854322195;19409.417717468357;19715;19860.304889328803;20668.276610318717;2390.7848293653656;2436.427439551704;2486.3038349262238;2495.36368226103;2514.3211332940186;113953;118306;118323.4083829584;127748.36125819404;134634;14723.674869261818;14955.252237388087;14992.325345359484;15003;15041.473548425753;22963.081476740743;23034;23097;23120.7687923122;23194;9874.851877221847;9972.252081093802;10003.24975626831;10088.092071713581;10121.139703125316;9229.123233292827;9243.44539327629;9282.164605185566;9295.070492950787;9391.295652826066;9060.773480663036;9176.265898728087;9198.804155459748;9378.07749411369;9414.29392795543;2598.3763896664664;2695.636089127943;2708.805867247536;2782.401783616532;2807.7332653397893;940.9200217981548;961.4808003678075;966.6471737815647;967.6129548180643;973.5862258540092;19225.327113551237;19240.518987025156;19422.417327480198;19638.509037274183;19692.50768730793;1000.7648202672366;1005.2812239248972;1026.5380578739598;1027.1885210683477;1030.0472063341379;10790;10879.782404351869;10927.398993055458;11011.229213954946;11030.50362733679;494705;504240;516015;519715;519970;109610;111806.44096779464;112388.43805780918;113598;115481.42259288649;1142.9542818287175;1155.1682788392345;1201.8257352683986;1213.9817902731465;1215.9878401216051;20211.292604758764;20444.795552044885;20592.69110963307;20639.380818575468;20822.375328740163;59153.40846591479;60430.39569604248;60801.39198608134;61584.69207653933;62379;76384;76513.23486765061;76703;77123;77406.6129669348;14311.856881431053;14480.637984050483;14705.264736762905;14765.114093154016;14766.852331476977;22691.773082268966;22813.543729125657;22871.542569148856;23247.41881452977;23501.41246468852;17693.734593981357;18018.36935707244;18025.549361266072;18034;18096.90951545234;16009.599760005627;16234.918825405797;16671.249793759067;16916.15419229009;16926.40757573479;18306.450806475827;18358.908205458887;18442.35451759182;18518.907405462887;18676.81323186805;14381.712365752835;14581.489647862698;14586.4894728684;14602.269886505845;14691.338889749773;17746;17792.822071779636;18067.45797626073;18174.72737908959;18429.354972575897 02:38:16 INFO - PID 4131 | |3;mootools.html;1300.674831292177;1354.1198221156244;1368.4457794593186;1372.8009438631393;1372.9244891530968;14353.856461435382;14851.851481485182;14873.330700118493;14895;15053.774193387095;15003.92498037511;15299.23503824807;15309.540713778577;15333.386664533406;15344.462943796969;2717.605947137669;2815.85920703965;2822.2238884306776;2822.7459528642416;2848.1882663440924;2710.186943916817;2804.242854429303;2822.0828230824964;2829.8726557304867;2832.5043117454466;2662.7337266273316;2753.7108603596635;2834.4189441164513;2845.260232339586;2854.029629925825;2805.8737356818788;2833.404984953152;2844.6586409630872;2854.0724264613877;2864.713528647129;2654.8672566371797;2674.318048897538;2698.298442404969;2709.065372446503;2713.511567917774;14472.493462728755;14793.186374749384;14795.852041479555;14865.851341486556;14880.255987200597;7726.266004729542;8011.8798218026195;8024.117347091816;8032.999999999942;8040.396970227198;5192.792288308463;5373.435789242112;5505.752241149118;5609.5792815539;5696.287964004499;1959.7550306211724;1975.5456245063715;1992.3823614679495;2045.764737055243;2048.3957232616413;26038.479230415476;26127.869360653076;26311.73688263112;26336.60495092575;26375.20874373772;6770.69531871067;6843.692033858389;6893.4829887758615;7094.6097964612445;7108.857822843514;16772.077535735407;16810.243539040774;16844.831551684325;16922.238499267318;16952.406665766637;7612.7716168515035;7728.26581474759;7740.729074482366;7755.573443460664;7788.493747906368;6962.268961759044;7051.083359163276;7059.858802823915;7136.179339375934;7255.310745479171;4966.751662416937;5112.335396398445;5177.352830896138;5198.740062996835;5199.142141546678;1317.0912070671206;1350.9932450337685;1500.6248437890526;1501.9711497624162;1550.7518796992654;883.5758835758871;908.0102688069903;915.5376534849859;934.2806039349663;936.7892224249489;8457.069722330662;8462.238398544161;8518.275946544612;8573.699920502877;8584.098669639723;722.3787542713262;726.3245181980809;730.8099894027591;732.3079689693295;799.7720649614832;5000.374953130859;5093.668911520739;5129.769160387791;5253.159494480865;5400.621956463088;19594.902025490068;21656.675149872764;21734.673979890315;21836.89081554582;22140.892955352167;21165.15339386438;21376.679349809765;21787.891060544596;21854.12583496674;21937.670934935988;10726.195535334726;10938.726531836768;10984.670459886216;11000.009999100119;11087.944560277147;8090.271875531231;8124.55314957683;8153.714619988272;8216.876746848682;8228.382871284797;18275.908620456812;18692.532686682942;18818;18938.337158199396;19193.424197274104;18618.906905465385;18706;18797.718034229772;19550.8044919549;19551.70672439886;10540.314879532805;10601.363918164934;10632.734181645521;10641.8935810644;10651.89348106509;13447.193168409927;13551.457941682616;13827.861721382658;13836.654083647989;13838.377273022537;10698.518566664674;10805.297655652357;10939.45302734876;10951.45242737876;11087.33475991443;10335.17318614494;10527.315724477885;10551.736206594896;10556.472176390997;10855.294405863593;9811.822581290291;9860.704178874645;9862.852057219005;9897.307188496736;9984;7322;7384.187739348775;7393.07586551681;7435.256474352522;7531.88702169457;7408.259174082548;7466.365358944333;7525.233103434656;7531.397488201041;7645.273698998586 02:38:16 INFO - PID 4131 | |4;prototype.html;496.41918954822853;510.79568172730905;536.5486359397828;541.0936681059225;544.3223187132019;6135;6208.751649934008;6231.750729970801;6249;6289.591176573519;6103.115048317991;6106;6137.938620613792;6153.846153846156;6163.476104531109;5077.187649976005;5079.1365467870455;5088.160453525164;5156.407013193474;5159.355080614923;4788.90422191556;5118.488151184889;5144.536991670749;5150.845474635767;5184.403793563751;4902.289168070645;4918.139325618021;4930.728809915453;4940.851774446773;4952.603791696655;4906.190478571031;4923.679960802554;4923.950760492385;4925.2858335541505;4933.358663373739;4312.654987600984;4419.40338054365;4435.68950173488;4444.488883778375;4445.755483448409;5992.550558708114;6006.699665016776;6010.128531362971;6033.245844269466;6071.787487437919;5623.80316688918;5628;5631.239782629334;5649.12438572022;5660.60375773696;6372.904406433907;6409.166808314936;6424.682939997289;6445.774397896098;6455.322191169907;4635.397398338228;4795.928061079087;4859.319695242669;4860.513948605147;4870.415550133971;6478.769033883547;6575.80272591823;6648.401643852028;6700.128983232149;6817.625030623363;4928.482509336468;4955.801767929314;4971.78191343116;4972.428170760337;4982.153033984159;5027.497250275016;5044.974775126101;5048.368953880765;5057.039162559102;5065.721385323843;5522.641028333145;5634.943650563524;5636.2954630671165;5645.181448689917;5680.517156041783;6348.841278968062;6406.231252249667;6432.388923052303;6452.9677351612945;6469.5794773339585;1711.1957380031365;1726.214572369569;1743.686136495443;1747.816479269684;1751.2907272554635;1145.9828102578467;1194.2535915053093;1216.6532538226563;1232.6733415644862;1237.2020047069589;5580.776768929279;5597.832065038056;5598.748056337475;5612.923218409214;5629.268195134607;6520.93516047457;6572.4084832365315;6600.80197594073;6609.735610575523;6615.140031795836;5406.864828379244;5628.831135065954;5651.976192736866;5667.688277144796;5715.742791574389;3350.1959529712694;3402.9791062681097;3428.6914177724125;3434.9313013739584;3438.570178727659;6287.937120628827;6350.650714210763;6354.555181137276;6367.458766004941;6369.840753981188;6522.869542609216;6624.701888414937;6626.0784372531425;6693.226295031723;6782.253952065269;6388.584741991755;6413.3266007069515;6414.139899429113;6499.415052645285;6548.380647740942;6530.771423000172;6544.640044797582;6558.8360290993105;6679.398854103154;6682.331766823473;6437.742490300336;6495.317991610813;6541.967290163519;6589.604623722592;6615.272320044695;6245.781397651061;6386.808395748135;6398.264199616918;6446.742130314735;6535.379138981789;5042.4705405931845;5066.771995260296;5068.467810879804;5081.161608334583;5084.542391184811;6308.814048905273;6410.839729006812;6575.947848344242;6687.765928192684;6757.932420675927;6180.4746596538;6292.150559674568;6356.841078972878;6406.583572067801;6433.485321174388;6277.717502712298;6281.183446151971;6371.203599550056;6425.518086143465;6509.349065093642;6274.309825919054;6299.6535190564955;6348.730253949137;6368.993766963577;6427.003814408774;6352.460040896575;6391.392817682313;6405.391487808651;6460.580062295936;6548.214214294315;6166.630002199882;6213.65824879636;6271.78048768291;6286.339934307015;6334.303226644974 02:38:16 INFO - PID 4131 | |5;yui.html;902.9097090290968;907.5416914458198;915.9862602060966;919.1589695428684;934.2525979216628;19166.137523811445;19769.901150494246;19823.5044123897;19828.50428739282;19943;16690.916545417254;16732.41436549721;16827;16869.40957066503;16870.662586748258;944.8866136063665;957.090763774417;960.13108137136;961.5721004153155;966.8694726211977;969.9951500242524;977.1352353167426;978.295627148452;980.3333733061515;981.1954197558006;990.3513198854762;1028.146638290221;1028.7736697926443;1030.294248439821;1036.2694300518117;1023;1034.9689509314694;1039.8648175737105;1040.0119886108153;1040.7814358984622;723.2839488905997;738.7119023580808;740.8036870229394;741.7589283482836;746.6714645555938;18249.817501824946;18884.15021324044;18957.33649322281;18987.33544325956;19782.80217197824;21447.463813404633;21467.248646297303;21704.914754262383;22212.333629991124;22390.104395824146;17325.306987720476;17556.824431755645;17622.91188544062;17636.735448968277;17762.911185444118;3628.9274214515563;3639.890803275906;3668.5047518584915;3675.1730860556163;3675.852965881388;110732;127163.36418317942;142011.2899435496;142702;145347;17721.468355949342;17764.644707106043;18059;18089.7286540702;18119.275228990693;31276.53085203724;32017.359652806812;32312.83843580767;32382.35235295281;32503;8803.955980220058;9097.272218222526;9103.135202155785;9147.359684822131;9181.632734690671;4302.526722060571;4368.737875727466;4390.385346051556;4414.4702635683925;4426.468823741172;5467.617266791366;5532.225488431623;5537.556995440355;5553.083741182741;5553.805931724618;1125.2685754259796;1134.4384529657707;1135.4663308245113;1139.0090621159645;1162.808136657459;647.3267801486495;660.1154453032959;678.1184460201816;685.0409426802416;687.1753895325629;12137.332446715338;12291.201071930474;12308.753824923451;12535.24788512692;12589.181703189264;678.2674711311771;681.9283975182534;692.7263730826396;699.0946723992442;710.2435905760452;5694.601377903507;5764.7117644117625;5816.302043754777;5845.941540584539;5889.734961926723;128515;130081;131806;132656;134784;101049;104501.47749261204;107393;108219;109389.45305273423;97640;100154;100724;100905;103048;10628.36229826213;10706.678799636024;10903.2367734261;10998.14834224233;11038.337699738042;44473.888152795145;45144.77427612841;46433.53566464292;46818;47313.763431182626;57630.4236957625;58309.416905830396;58660.41339586549;59508.70245648744;59703;15210.847891520943;15746.76379854326;15925.522234332988;16077.839221607634;16117.597060073593;18137.81862181414;18205.817941820413;18225.544361391072;18320.633587327913;18400.63198735991;16089.919550402174;16141.919290403473;16285.755713664541;16296.918515407822;16378.344866205218;16156.596085097497;16270.918645407171;16443.753343700093;16577.66844663124;16740.832591673927;15036.849631503545;15227.390904363701;15281.312340944907;15313.081215127128;15353;10371.170306375321;10509.527071281658;10609.787804244026;10690.037896589345;10695.304805187638;11862.288262704265;12099.213551119501;12115;12145.332006739362;12175.147739658492 02:38:16 INFO - PID 4131 | __end_tp_report 02:38:16 INFO - PID 4131 | __start_cc_report 02:38:16 INFO - PID 4131 | _x_x_mozilla_cycle_collect,281 02:38:16 INFO - PID 4131 | __end_cc_report 02:38:16 INFO - PID 4131 | __startTimestamp1506764296585__endTimestamp 02:38:16 INFO - PID 4131 | 02:38:16 INFO - PID 4131 | ------- Summary: start ------- 02:38:16 INFO - PID 4131 | Number of tests: 6 02:38:16 INFO - PID 4131 | 02:38:16 INFO - PID 4131 | [#0] dojo.html Cycles:165 Average:6130.39 Median:6338.49 stddev:739.77 (11.7%) stddev-sans-first:703.58 02:38:16 INFO - PID 4131 | Values: 3129.5 3150.4 3166.7 3172.3 3177.0 6050.3 6070.7 6118.8 6179.8 6183.5 6135.8 6185.3 6220.4 6243.3 6278.1 5670.2 5673.6 5691.1 5720.2 5732.2 5647.5 5647.7 5707.2 5711.4 5749.1 5641.2 5669.9 5690.3 5698.7 5769.1 5536.6 5715.4 5743.7 5769.3 5771.5 5605.1 5621.5 5627.7 5718.0 5752.2 6146.8 6197.8 6225.3 6275.8 6280.7 6525.9 6602.5 6627.1 6680.3 6689.7 6734.1 6740.3 6774.9 6782.5 6826.4 6170.2 6182.8 6242.9 6296.2 6307.3 6855.8 6867.0 6884.6 6940.8 6954.3 6456.1 6461.0 6465.8 6550.6 6701.7 6519.9 6542.9 6554.3 6565.4 6634.4 6543.9 6586.5 6604.0 6741.8 6751.0 6715.2 6734.6 6808.7 6813.8 6813.9 5226.4 5260.9 5263.3 5264.4 5286.1 4482.6 4500.5 4510.5 4553.7 4640.5 5788.5 5823.4 5823.9 5844.2 5845.2 6778.5 6789.4 6793.5 6808.5 6815.0 5779.9 5785.7 5867.5 5872.1 5875.0 5566.5 5689.9 5709.4 5718.8 5827.7 6437.4 6492.1 6533.0 6573.1 6580.8 6709.2 6755.9 6766.4 6790.8 6794.9 6510.2 6527.0 6590.4 6611.0 6628.1 6396.1 6502.2 6584.0 6620.8 6728.7 6644.4 6673.7 6686.8 6688.4 6695.5 6338.5 6383.4 6442.4 6532.1 6566.4 6426.7 6441.9 6453.2 6502.7 6515.2 6318.5 6348.3 6419.7 6443.8 6444.1 6338.0 6456.0 6488.0 6493.9 6515.8 6171.1 6249.5 6250.1 6269.2 6273.3 02:38:16 INFO - PID 4131 | 02:38:16 INFO - PID 4131 | [#1] ext.html Cycles:180 Average:36562.98 Median:33686.58 stddev:53054.35 (157.5%) stddev-sans-first:53135.49 02:38:16 INFO - PID 4131 | Values: 871.1 899.3 904.6 909.4 910.2 38664.0 39814.8 42519.1 42607.0 43013.8 39241.4 39342.2 39627.4 39813.8 39831.8 7174.5 7324.6 7339.4 7342.0 7364.0 7870.2 8065.2 8073.3 8084.6 8089.2 8101.2 8107.8 8109.8 8114.7 8160.9 7869.0 8013.8 8075.6 8075.8 8078.6 7911.5 7952.0 8001.8 8005.8 8008.0 37741.6 37905.4 38347.0 38581.6 38712.2 3520.3 3541.8 3545.9 3603.3 3619.7 31071.5 31150.7 31525.0 31531.0 31633.1 5093.1 5151.1 5198.5 5210.6 5261.8 181764.0 182362.0 182790.0 183166.0 183205.0 41682.0 41773.8 46604.0 46645.8 46859.5 43828.8 49818.0 50132.0 50319.0 51023.2 14892.6 14945.6 15028.8 15050.4 15075.5 12036.2 12048.9 12076.5 12128.9 12135.5 13490.0 13665.7 13802.1 13819.8 14007.2 5687.4 5719.6 5723.3 5783.7 5795.2 974.3 986.0 988.7 1002.1 1016.0 22417.9 22511.5 22526.3 22591.7 23038.4 1095.6 1107.4 1108.2 1110.1 1110.2 12223.9 12285.0 12286.8 12347.2 12367.6 227521.0 228466.0 228634.0 229736.0 229846.0 52862.5 53114.2 53615.5 53764.7 53814.2 1410.3 1440.0 1447.2 1447.5 1449.9 22043.6 22154.2 22169.8 22555.3 22759.8 35364.5 35765.8 35775.8 35821.0 35836.8 198075.0 199715.0 199817.0 201111.0 201502.0 27842.6 29664.0 30043.0 30233.8 32452.0 36460.5 40557.2 40611.0 40861.8 41193.8 29785.4 29796.0 30040.5 30249.8 30664.0 29152.7 29190.7 29448.3 29553.9 30259.7 32297.2 33133.0 33173.5 33480.5 33892.7 28721.0 29328.6 29446.0 29634.4 30112.2 22279.8 22345.9 22652.7 22693.4 22839.5 02:38:16 INFO - PID 4131 | 02:38:16 INFO - PID 4131 | [#2] jquery.html Cycles:180 Average:35107.13 Median:22917.31 stddev:85366.80 (372.5%) stddev-sans-first:85566.87 02:38:16 INFO - PID 4131 | Values: 560.9 571.6 584.0 596.4 605.7 21226.9 21940.2 21964.7 21994.5 22027.4 23938.2 24294.1 24417.8 25443.1 25572.0 6479.5 6544.4 6603.6 6620.5 6654.6 6539.8 6614.7 6631.1 6635.5 6638.1 6441.2 6679.0 6689.7 6705.3 6717.1 6618.1 6644.0 6715.6 6724.7 6729.4 5988.5 6119.3 6230.1 6260.1 6267.7 28845.7 29358.6 29458.3 29523.6 29558.4 2004.6 2032.0 2035.6 2044.5 2049.5 19209.7 19409.4 19715.0 19860.3 20668.3 2390.8 2436.4 2486.3 2495.4 2514.3 113953.0 118306.0 118323.4 127748.4 134634.0 14723.7 14955.3 14992.3 15003.0 15041.5 22963.1 23034.0 23097.0 23120.8 23194.0 9874.9 9972.3 10003.2 10088.1 10121.1 9229.1 9243.4 9282.2 9295.1 9391.3 9060.8 9176.3 9198.8 9378.1 9414.3 2598.4 2695.6 2708.8 2782.4 2807.7 940.9 961.5 966.6 967.6 973.6 19225.3 19240.5 19422.4 19638.5 19692.5 1000.8 1005.3 1026.5 1027.2 1030.0 10790.0 10879.8 10927.4 11011.2 11030.5 494705.0 504240.0 516015.0 519715.0 519970.0 109610.0 111806.4 112388.4 113598.0 115481.4 1143.0 1155.2 1201.8 1214.0 1216.0 20211.3 20444.8 20592.7 20639.4 20822.4 59153.4 60430.4 60801.4 61584.7 62379.0 76384.0 76513.2 76703.0 77123.0 77406.6 14311.9 14480.6 14705.3 14765.1 14766.9 22691.8 22813.5 22871.5 23247.4 23501.4 17693.7 18018.4 18025.5 18034.0 18096.9 16009.6 16234.9 16671.2 16916.2 16926.4 18306.5 18358.9 18442.4 18518.9 18676.8 14381.7 14581.5 14586.5 14602.3 14691.3 17746.0 17792.8 18067.5 18174.7 18429.4 02:38:16 INFO - PID 4131 | 02:38:16 INFO - PID 4131 | [#3] mootools.html Cycles:180 Average:9246.71 Median:2711.85 stddev:6598.32 (243.3%) stddev-sans-first:6589.82 02:38:16 INFO - PID 4131 | Values: 1300.7 1354.1 1368.4 1372.8 1372.9 14353.9 14851.9 14873.3 14895.0 15053.8 15003.9 15299.2 15309.5 15333.4 15344.5 2717.6 2815.9 2822.2 2822.7 2848.2 2710.2 2804.2 2822.1 2829.9 2832.5 2662.7 2753.7 2834.4 2845.3 2854.0 2805.9 2833.4 2844.7 2854.1 2864.7 2654.9 2674.3 2698.3 2709.1 2713.5 14472.5 14793.2 14795.9 14865.9 14880.3 7726.3 8011.9 8024.1 8033.0 8040.4 5192.8 5373.4 5505.8 5609.6 5696.3 1959.8 1975.5 1992.4 2045.8 2048.4 26038.5 26127.9 26311.7 26336.6 26375.2 6770.7 6843.7 6893.5 7094.6 7108.9 16772.1 16810.2 16844.8 16922.2 16952.4 7612.8 7728.3 7740.7 7755.6 7788.5 6962.3 7051.1 7059.9 7136.2 7255.3 4966.8 5112.3 5177.4 5198.7 5199.1 1317.1 1351.0 1500.6 1502.0 1550.8 883.6 908.0 915.5 934.3 936.8 8457.1 8462.2 8518.3 8573.7 8584.1 722.4 726.3 730.8 732.3 799.8 5000.4 5093.7 5129.8 5253.2 5400.6 19594.9 21656.7 21734.7 21836.9 22140.9 21165.2 21376.7 21787.9 21854.1 21937.7 10726.2 10938.7 10984.7 11000.0 11087.9 8090.3 8124.6 8153.7 8216.9 8228.4 18275.9 18692.5 18818.0 18938.3 19193.4 18618.9 18706.0 18797.7 19550.8 19551.7 10540.3 10601.4 10632.7 10641.9 10651.9 13447.2 13551.5 13827.9 13836.7 13838.4 10698.5 10805.3 10939.5 10951.5 11087.3 10335.2 10527.3 10551.7 10556.5 10855.3 9811.8 9860.7 9862.9 9897.3 9984.0 7322.0 7384.2 7393.1 7435.3 7531.9 7408.3 7466.4 7525.2 7531.4 7645.3 02:38:16 INFO - PID 4131 | 02:38:16 INFO - PID 4131 | [#4] prototype.html Cycles:180 Average:5428.25 Median:6104.56 stddev:1506.14 (24.7%) stddev-sans-first:1464.17 02:38:16 INFO - PID 4131 | Values: 496.4 510.8 536.5 541.1 544.3 6135.0 6208.8 6231.8 6249.0 6289.6 6103.1 6106.0 6137.9 6153.8 6163.5 5077.2 5079.1 5088.2 5156.4 5159.4 4788.9 5118.5 5144.5 5150.8 5184.4 4902.3 4918.1 4930.7 4940.9 4952.6 4906.2 4923.7 4924.0 4925.3 4933.4 4312.7 4419.4 4435.7 4444.5 4445.8 5992.6 6006.7 6010.1 6033.2 6071.8 5623.8 5628.0 5631.2 5649.1 5660.6 6372.9 6409.2 6424.7 6445.8 6455.3 4635.4 4795.9 4859.3 4860.5 4870.4 6478.8 6575.8 6648.4 6700.1 6817.6 4928.5 4955.8 4971.8 4972.4 4982.2 5027.5 5045.0 5048.4 5057.0 5065.7 5522.6 5634.9 5636.3 5645.2 5680.5 6348.8 6406.2 6432.4 6453.0 6469.6 1711.2 1726.2 1743.7 1747.8 1751.3 1146.0 1194.3 1216.7 1232.7 1237.2 5580.8 5597.8 5598.7 5612.9 5629.3 6520.9 6572.4 6600.8 6609.7 6615.1 5406.9 5628.8 5652.0 5667.7 5715.7 3350.2 3403.0 3428.7 3434.9 3438.6 6287.9 6350.7 6354.6 6367.5 6369.8 6522.9 6624.7 6626.1 6693.2 6782.3 6388.6 6413.3 6414.1 6499.4 6548.4 6530.8 6544.6 6558.8 6679.4 6682.3 6437.7 6495.3 6542.0 6589.6 6615.3 6245.8 6386.8 6398.3 6446.7 6535.4 5042.5 5066.8 5068.5 5081.2 5084.5 6308.8 6410.8 6575.9 6687.8 6757.9 6180.5 6292.2 6356.8 6406.6 6433.5 6277.7 6281.2 6371.2 6425.5 6509.3 6274.3 6299.7 6348.7 6369.0 6427.0 6352.5 6391.4 6405.4 6460.6 6548.2 6166.6 6213.7 6271.8 6286.3 6334.3 02:38:16 INFO - PID 4131 | 02:38:16 INFO - PID 4131 | [#5] yui.html Cycles:180 Average:24610.46 Median:18237.68 stddev:35731.87 (195.9%) stddev-sans-first:35787.77 02:38:16 INFO - PID 4131 | Values: 902.9 907.5 916.0 919.2 934.3 19166.1 19769.9 19823.5 19828.5 19943.0 16690.9 16732.4 16827.0 16869.4 16870.7 944.9 957.1 960.1 961.6 966.9 970.0 977.1 978.3 980.3 981.2 990.4 1028.1 1028.8 1030.3 1036.3 1023.0 1035.0 1039.9 1040.0 1040.8 723.3 738.7 740.8 741.8 746.7 18249.8 18884.2 18957.3 18987.3 19782.8 21447.5 21467.2 21704.9 22212.3 22390.1 17325.3 17556.8 17622.9 17636.7 17762.9 3628.9 3639.9 3668.5 3675.2 3675.9 110732.0 127163.4 142011.3 142702.0 145347.0 17721.5 17764.6 18059.0 18089.7 18119.3 31276.5 32017.4 32312.8 32382.4 32503.0 8804.0 9097.3 9103.1 9147.4 9181.6 4302.5 4368.7 4390.4 4414.5 4426.5 5467.6 5532.2 5537.6 5553.1 5553.8 1125.3 1134.4 1135.5 1139.0 1162.8 647.3 660.1 678.1 685.0 687.2 12137.3 12291.2 12308.8 12535.2 12589.2 678.3 681.9 692.7 699.1 710.2 5694.6 5764.7 5816.3 5845.9 5889.7 128515.0 130081.0 131806.0 132656.0 134784.0 101049.0 104501.5 107393.0 108219.0 109389.5 97640.0 100154.0 100724.0 100905.0 103048.0 10628.4 10706.7 10903.2 10998.1 11038.3 44473.9 45144.8 46433.5 46818.0 47313.8 57630.4 58309.4 58660.4 59508.7 59703.0 15210.8 15746.8 15925.5 16077.8 16117.6 18137.8 18205.8 18225.5 18320.6 18400.6 16089.9 16141.9 16285.8 16296.9 16378.3 16156.6 16270.9 16443.8 16577.7 16740.8 15036.8 15227.4 15281.3 15313.1 15353.0 10371.2 10509.5 10609.8 10690.0 10695.3 11862.3 12099.2 12115.0 12145.3 12175.1 02:38:16 INFO - PID 4131 | -------- Summary: end -------- 02:38:16 INFO - PID 4131 | 02:38:17 INFO - TEST-INFO | 4131: exit 0 02:38:17 INFO - TEST-OK | dromaeo_css | took 1114891ms 02:38:17 INFO - TEST-START | kraken 02:38:17 INFO - Initialising browser for kraken test... 02:38:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38550/getInfo.html -profile /tmp/tmphAdOJL/profile 02:38:17 INFO - TEST-INFO | started process 4526 (/builds/slave/test/build/application/firefox/firefox http://localhost:38550/getInfo.html) 02:38:22 INFO - TEST-INFO | 4526: exit 0 02:38:23 INFO - Browser initialized. 02:38:23 INFO - Running cycle 1/1 for kraken test... 02:38:23 INFO - Using env: {'DISPLAY': ':0', 02:38:23 INFO - 'HOME': '/home/cltbld', 02:38:23 INFO - 'JSGC_DISABLE_POISONING': '1', 02:38:23 INFO - 'LANG': 'en_US.UTF-8', 02:38:23 INFO - 'LANGUAGE': 'en_US:en', 02:38:23 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:38:23 INFO - 'LOGNAME': 'cltbld', 02:38:23 INFO - 'MAIL': '/var/mail/cltbld', 02:38:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:38:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:38:23 INFO - 'MOZ_ACCELERATED': '1', 02:38:23 INFO - 'MOZ_CRASHREPORTER': '1', 02:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:23 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:38:23 INFO - 'MOZ_NO_REMOTE': '1', 02:38:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:38:23 INFO - 'MOZ_WEBRENDER': '1', 02:38:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:23 INFO - 'NO_EM_RESTART': '1', 02:38:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:23 INFO - 'PWD': '/builds/slave/test', 02:38:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:38:23 INFO - 'RUST_BACKTRACE': 'full', 02:38:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:38:23 INFO - 'SHELL': '/bin/bash', 02:38:23 INFO - 'SHLVL': '1', 02:38:23 INFO - 'TERM': 'linux', 02:38:23 INFO - 'TMOUT': '86400', 02:38:23 INFO - 'USER': 'cltbld', 02:38:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673', 02:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:23 INFO - '_': '/tools/buildbot/bin/python'} 02:38:23 INFO - TEST-INFO | started process 4771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphAdOJL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:23 INFO - PID 4771 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:38:23 INFO - PID 4771 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 02:38:24 INFO - PID 4771 | 02:38:24 INFO - PID 4771 | (/builds/slave/test/build/application/firefox/firefox:4830): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:38:24 INFO - PID 4771 | 02:38:34 INFO - PID 4771 | RSS: Main: 190984192 02:38:34 INFO - PID 4771 | 02:38:37 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38550/tests/kraken/driver.html?testName=audio-beat-detection) 02:38:38 INFO - PID 4771 | RSS: Main: 187174912 02:38:38 INFO - PID 4771 | 02:38:40 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38550/tests/kraken/driver.html?testName=audio-dft) 02:38:41 INFO - PID 4771 | RSS: Main: 187506688 02:38:41 INFO - PID 4771 | 02:38:44 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38550/tests/kraken/driver.html?testName=audio-fft) 02:38:45 INFO - PID 4771 | RSS: Main: 185012224 02:38:45 INFO - PID 4771 | 02:38:47 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38550/tests/kraken/driver.html?testName=audio-oscillator) 02:38:47 INFO - PID 4771 | RSS: Main: 185786368 02:38:47 INFO - PID 4771 | 02:38:50 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38550/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:38:50 INFO - PID 4771 | RSS: Main: 186142720 02:38:50 INFO - PID 4771 | 02:38:53 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38550/tests/kraken/driver.html?testName=imaging-darkroom) 02:38:54 INFO - PID 4771 | RSS: Main: 188719104 02:38:54 INFO - PID 4771 | 02:38:58 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38550/tests/kraken/driver.html?testName=imaging-desaturate) 02:38:58 INFO - PID 4771 | RSS: Main: 187891712 02:38:58 INFO - PID 4771 | 02:39:01 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38550/tests/kraken/driver.html?testName=json-parse-financial) 02:39:02 INFO - PID 4771 | RSS: Main: 188723200 02:39:02 INFO - PID 4771 | 02:39:04 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38550/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:39:04 INFO - PID 4771 | RSS: Main: 188846080 02:39:04 INFO - PID 4771 | 02:39:06 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38550/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:39:07 INFO - PID 4771 | RSS: Main: 185757696 02:39:07 INFO - PID 4771 | 02:39:09 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38550/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:39:10 INFO - PID 4771 | RSS: Main: 185245696 02:39:10 INFO - PID 4771 | 02:39:12 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38550/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:39:13 INFO - PID 4771 | RSS: Main: 185663488 02:39:13 INFO - PID 4771 | 02:39:16 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38550/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:39:16 INFO - PID 4771 | RSS: Main: 186048512 02:39:16 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | Cycle 1(1): loaded http://localhost:38550/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38550/tests/kraken/driver.html?testName=ai-astar) 02:39:18 INFO - PID 4771 | RSS: Main: 187047936 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | __start_tp_report 02:39:18 INFO - PID 4771 | _x_x_mozilla_page_load 02:39:18 INFO - PID 4771 | _x_x_mozilla_page_load_details 02:39:18 INFO - PID 4771 | |i|pagename|runs| 02:39:18 INFO - PID 4771 | |0;ai-astar;122;117;116;109;113;108;119;114;109;115 02:39:18 INFO - PID 4771 | |1;audio-beat-detection;116;125;131;120;128;117;126;124;116;129 02:39:18 INFO - PID 4771 | |2;audio-dft;162;166;170;163;162;168;168;168;165;164 02:39:18 INFO - PID 4771 | |3;audio-fft;73;76;80;85;74;73;78;78;81;74 02:39:18 INFO - PID 4771 | |4;audio-oscillator;79;80;79;83;82;86;79;79;79;83 02:39:18 INFO - PID 4771 | |5;imaging-gaussian-blur;120;115;124;112;111;121;113;112;114;111 02:39:18 INFO - PID 4771 | |6;imaging-darkroom;151;153;151;150;150;148;149;149;154;147 02:39:18 INFO - PID 4771 | |7;imaging-desaturate;109;94;96;94;94;95;94;95;95;94 02:39:18 INFO - PID 4771 | |8;json-parse-financial;51;53;51;53;63;52;55;64;52;50 02:39:18 INFO - PID 4771 | |9;json-stringify-tinderbox;41;43;37;38;38;47;44;41;47;38 02:39:18 INFO - PID 4771 | |10;stanford-crypto-aes;75;76;80;75;79;83;78;77;78;74 02:39:18 INFO - PID 4771 | |11;stanford-crypto-ccm;115;118;114;120;118;113;116;115;116;111 02:39:18 INFO - PID 4771 | |12;stanford-crypto-pbkdf2;161;162;161;159;161;165;158;167;171;169 02:39:18 INFO - PID 4771 | |13;stanford-crypto-sha256-iterative;63;62;63;70;66;65;64;66;67;66 02:39:18 INFO - PID 4771 | __end_tp_report 02:39:18 INFO - PID 4771 | __start_cc_report 02:39:18 INFO - PID 4771 | _x_x_mozilla_cycle_collect,779 02:39:18 INFO - PID 4771 | __end_cc_report 02:39:18 INFO - PID 4771 | __startTimestamp1506764358781__endTimestamp 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | ------- Summary: start ------- 02:39:18 INFO - PID 4771 | Number of tests: 14 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.50 stddev:4.59 (4.0%) stddev-sans-first:3.91 02:39:18 INFO - PID 4771 | Values: 122.0 117.0 116.0 109.0 113.0 108.0 119.0 114.0 109.0 115.0 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#1] audio-beat-detection Cycles:10 Average:123.20 Median:125.50 stddev:5.59 (4.5%) stddev-sans-first:5.29 02:39:18 INFO - PID 4771 | Values: 116.0 125.0 131.0 120.0 128.0 117.0 126.0 124.0 116.0 129.0 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#2] audio-dft Cycles:10 Average:165.60 Median:167.00 stddev:2.84 (1.7%) stddev-sans-first:2.69 02:39:18 INFO - PID 4771 | Values: 162.0 166.0 170.0 163.0 162.0 168.0 168.0 168.0 165.0 164.0 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#3] audio-fft Cycles:10 Average:77.20 Median:78.00 stddev:3.97 (5.1%) stddev-sans-first:3.91 02:39:18 INFO - PID 4771 | Values: 73.0 76.0 80.0 85.0 74.0 73.0 78.0 78.0 81.0 74.0 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#4] audio-oscillator Cycles:10 Average:80.90 Median:81.00 stddev:2.47 (3.0%) stddev-sans-first:2.52 02:39:18 INFO - PID 4771 | Values: 79.0 80.0 79.0 83.0 82.0 86.0 79.0 79.0 79.0 83.0 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:114.50 stddev:4.67 (4.1%) stddev-sans-first:4.63 02:39:18 INFO - PID 4771 | Values: 120.0 115.0 124.0 112.0 111.0 121.0 113.0 112.0 114.0 111.0 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.50 stddev:2.15 (1.4%) stddev-sans-first:2.26 02:39:18 INFO - PID 4771 | Values: 151.0 153.0 151.0 150.0 150.0 148.0 149.0 149.0 154.0 147.0 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:94.50 stddev:4.62 (4.9%) stddev-sans-first:0.73 02:39:18 INFO - PID 4771 | Values: 109.0 94.0 96.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:53.00 stddev:4.99 (9.4%) stddev-sans-first:5.14 02:39:18 INFO - PID 4771 | Values: 51.0 53.0 51.0 53.0 63.0 52.0 55.0 64.0 52.0 50.0 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#9] json-stringify-tinderbox Cycles:10 Average:41.40 Median:42.00 stddev:3.75 (8.9%) stddev-sans-first:3.97 02:39:18 INFO - PID 4771 | Values: 41.0 43.0 37.0 38.0 38.0 47.0 44.0 41.0 47.0 38.0 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:78.00 stddev:2.72 (3.5%) stddev-sans-first:2.73 02:39:18 INFO - PID 4771 | Values: 75.0 76.0 80.0 75.0 79.0 83.0 78.0 77.0 78.0 74.0 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#11] stanford-crypto-ccm Cycles:10 Average:115.60 Median:116.00 stddev:2.63 (2.3%) stddev-sans-first:2.78 02:39:18 INFO - PID 4771 | Values: 115.0 118.0 114.0 120.0 118.0 113.0 116.0 115.0 116.0 111.0 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.40 Median:163.50 stddev:4.38 (2.7%) stddev-sans-first:4.56 02:39:18 INFO - PID 4771 | Values: 161.0 162.0 161.0 159.0 161.0 165.0 158.0 167.0 171.0 169.0 02:39:18 INFO - PID 4771 | 02:39:18 INFO - PID 4771 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:66.00 stddev:2.35 (3.6%) stddev-sans-first:2.35 02:39:18 INFO - PID 4771 | Values: 63.0 62.0 63.0 70.0 66.0 65.0 64.0 66.0 67.0 66.0 02:39:18 INFO - PID 4771 | -------- Summary: end -------- 02:39:18 INFO - PID 4771 | 02:39:19 INFO - PID 4771 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:39:19 INFO - TEST-INFO | 4771: exit 0 02:39:19 INFO - TEST-OK | kraken | took 62317ms 02:39:19 INFO - SUITE-END | took 1177s 02:39:19 INFO - Completed test suite (00:19:37) 02:39:19 INFO - javascript benchmark 02:39:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8446.001495658107, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3129.499280115182, 3150.4014237294914, 3166.683331666832, 3172.254520187756, 3176.9523457148134, 6050.334463209049, 6070.696465176746, 6118.755249790003, 6179.752809887605, 6183.474404675608, 6135.81592552223, 6185.319614842364, 6220.409061139185, 6243.344448832864, 6278.121063051165, 5670.206171136044, 5673.602847800656, 5691.117876729103, 5720.1991721158865, 5732.197492351074, 5647.463490968372, 5647.689377084259, 5707.229524014247, 5711.400302968191, 5749.080147176453, 5641.153826925974, 5669.8582535436535, 5690.2887139107615, 5698.715064246771, 5769.134629805541, 5536.612437129403, 5715.428457154293, 5743.655380677131, 5769.336526299488, 5771.538276937835, 5605.131204663284, 5621.522170615503, 5627.6904770237625, 5718.0, 5752.165935939307, 6146.7541298348015, 6197.81406557804, 6225.28409232935, 6275.780347687854, 6280.748770049193, 6525.869482610368, 6602.471802255856, 6627.105340778981, 6680.331966803329, 6689.665516724144, 6734.124563806723, 6740.258571557125, 6774.932250677529, 6782.5252232343755, 6826.385625293748, 6170.228721409824, 6182.783602573933, 6242.906356404657, 6296.244450665904, 6307.306196318401, 6855.828604284833, 6867.0, 6884.552504087218, 6940.757073502403, 6954.3045695431065, 6456.12842266288, 6461.030845373231, 6465.77369792055, 6550.639714815731, 6701.731930722814, 6519.934800651933, 6542.869142617121, 6554.3117972613145, 6565.376289252514, 6634.40290373859, 6543.934560654333, 6586.538942274091, 6604.009398590154, 6741.831454213586, 6751.0, 6715.160604924385, 6734.629595372302, 6808.7276508939085, 6813.761518346834, 6813.897791533131, 5226.398964119099, 5260.92108618371, 5263.34208223972, 5264.394594621591, 5286.127788914863, 4482.610390778869, 4500.549945005539, 4510.503844577094, 4553.749543775058, 4640.512746161672, 5788.479036886701, 5823.417658234227, 5823.88352232953, 5844.15259787337, 5845.210896528914, 6778.525503214826, 6789.422899053537, 6793.490488213404, 6808.455323574102, 6814.965925170342, 5779.8555036124435, 5785.71071446426, 5867.471927526458, 5872.11918212263, 5875.030619947746, 5566.471185237396, 5689.886202275931, 5709.371969083398, 5718.828435146952, 5827.650340979555, 6437.388448097423, 6492.058651495507, 6533.0, 6573.112629795012, 6580.76967306142, 6709.161354830646, 6755.86488270222, 6766.391024807791, 6790.830229244309, 6794.8641027180165, 6510.21877374718, 6526.967365163144, 6590.406863382319, 6611.0, 6628.138342015507, 6396.072569477306, 6502.187226596676, 6584.0, 6620.801375958729, 6728.663566821737, 6644.368784965421, 6673.699683514351, 6686.83282917931, 6688.398044176048, 6695.531312808057, 6338.492920566251, 6383.361663833765, 6442.35576442352, 6532.118164047983, 6566.409023187936, 6426.710798014007, 6441.935580644321, 6453.225612926479, 6502.707378168088, 6515.218173819172, 6318.526110541636, 6348.269948955929, 6419.711112999833, 6443.838904027437, 6444.065610486547, 6338.049292606146, 6455.999320105391, 6488.0, 6493.935060649522, 6515.837104072436, 6171.074338849208, 6249.500039996698, 6250.06249062626, 6269.216347956505, 6273.341299163522], "value": 6074.152991595508, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [871.0984131423976, 899.2715900120901, 904.6155383961815, 909.4225167018949, 910.1808372464781, 38664.0, 39814.80092599537, 42519.14961700764, 42607.0, 43013.78493107538, 39241.41137882927, 39342.21315573694, 39627.40558891619, 39813.800930995305, 39831.800840995755, 7174.497785155041, 7324.560526368408, 7339.376153026999, 7342.045534080562, 7364.042674452314, 7870.212978702112, 8065.1934806519175, 8073.313768329699, 8084.555349455778, 8089.191080891923, 8101.230383113624, 8107.837843243132, 8109.797255068641, 8114.715984940528, 8160.918390816075, 7869.016372953381, 8013.799655008613, 8075.636596353178, 8075.798105047392, 8078.636461359253, 7911.485753426009, 7952.045754509438, 8001.759947201535, 8005.799855003614, 8008.039035315741, 37741.62258377436, 37905.431418528744, 38347.041323967125, 38581.614183858364, 38712.22575548473, 3520.3135388599235, 3541.8052007139595, 3545.9113522161892, 3603.3333833240936, 3619.6561326673923, 31071.533926991113, 31150.688493115005, 31525.0, 31531.0, 31633.05100846978, 5093.083245015896, 5151.124308867464, 5198.4801519847715, 5210.583153347723, 5261.815836445706, 181764.0, 182362.0, 182790.0, 183166.0, 183205.0, 41682.0, 41773.79113104415, 46604.0, 46645.76677116593, 46859.5314046862, 43828.780856095516, 49818.0, 50132.0, 50319.0, 51023.234651480256, 14892.553223403314, 14945.551633451014, 15028.774568381483, 15050.397984080515, 15075.472358467401, 12036.217645852992, 12048.87951120495, 12076.516939322504, 12128.939355303168, 12135.453904574315, 13490.0, 13665.658358541115, 13802.102863314054, 13819.792703109462, 14007.229602371763, 5687.431256874363, 5719.571032172604, 5723.313202415737, 5783.7397317119985, 5795.217645617872, 974.2644303550916, 985.9654912078042, 988.6539711101057, 1002.0880998291519, 1015.9593616255268, 22417.88791056067, 22511.549769004527, 22526.324210273717, 22591.661125082806, 23038.424039398815, 1095.5782023920688, 1107.3521989636154, 1108.2187058124002, 1110.0509064749683, 1110.245033377295, 12223.877761222275, 12285.0, 12286.75426491465, 12347.196817495762, 12367.567135150226, 227521.0, 228466.0, 228634.0, 229736.0, 229846.0, 52862.47137528652, 53114.203286950724, 53615.463845361824, 53764.73117634387, 53814.19278710822, 1410.2737090398452, 1439.9568012959628, 1447.232966527742, 1447.486142419447, 1449.9202543859979, 22043.559128817655, 22154.22460213885, 22169.77830221677, 22555.323340299816, 22759.772402275765, 35364.46953295754, 35765.82117089398, 35775.82112089423, 35821.0, 35836.82081589576, 198075.0, 199715.0, 199817.0, 201111.0, 201502.0, 27842.58236126419, 29664.0, 30043.0, 30233.848830755705, 32452.0, 36460.45309320309, 40557.18885622212, 40611.0, 40861.795691021354, 41193.794031030855, 29785.404291913608, 29796.0, 30040.549391759578, 30249.848750756104, 30664.0, 29152.708472915, 29190.70809291965, 29448.263793405335, 29553.85223073871, 30259.69740302569, 32297.192570185933, 33133.0, 33173.50239746454, 33480.497792532646, 33892.661073388954, 28721.0, 29328.560071598517, 29446.0, 29634.407311854073, 30112.24719382033, 22279.77720222777, 22345.888270558542, 22652.660210096532, 22693.43266418353, 22839.54320913539], "value": 16748.60515008397, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.9074502707053, 571.5620542437243, 584.0, 596.3559355895633, 605.6668832142321, 21226.89386553067, 21940.232091876787, 21964.670529942025, 21994.45013874654, 22027.449313767163, 23938.16216432425, 24294.11442540838, 24417.75582244177, 25443.109491167812, 25572.0, 6479.481641468683, 6544.411003009728, 6603.603783772965, 6620.470362370998, 6654.600723956578, 6539.836504087389, 6614.669266536654, 6631.071649969008, 6635.469162466991, 6638.1370421845095, 6441.227052753676, 6679.0, 6689.665516724169, 6705.295943925891, 6717.126773519436, 6618.106555614979, 6644.0, 6715.630640314781, 6724.663766811665, 6729.360710732472, 5988.461038506512, 6119.296280927661, 6230.096635987802, 6260.09228661846, 6267.71795269214, 28845.71154288472, 29358.559621605695, 29458.263543411373, 29523.55714664282, 29558.408831823457, 2004.5589970206531, 2031.9593608127902, 2035.5827055453597, 2044.4582185720647, 2049.4876280929766, 19209.711854322195, 19409.417717468357, 19715.0, 19860.304889328803, 20668.276610318717, 2390.7848293653656, 2436.427439551704, 2486.3038349262238, 2495.36368226103, 2514.3211332940186, 113953.0, 118306.0, 118323.4083829584, 127748.36125819404, 134634.0, 14723.674869261818, 14955.252237388087, 14992.325345359484, 15003.0, 15041.473548425753, 22963.081476740743, 23034.0, 23097.0, 23120.7687923122, 23194.0, 9874.851877221847, 9972.252081093802, 10003.24975626831, 10088.092071713581, 10121.139703125316, 9229.123233292827, 9243.44539327629, 9282.164605185566, 9295.070492950787, 9391.295652826066, 9060.773480663036, 9176.265898728087, 9198.804155459748, 9378.07749411369, 9414.29392795543, 2598.3763896664664, 2695.636089127943, 2708.805867247536, 2782.401783616532, 2807.7332653397893, 940.9200217981548, 961.4808003678075, 966.6471737815647, 967.6129548180643, 973.5862258540092, 19225.327113551237, 19240.518987025156, 19422.417327480198, 19638.509037274183, 19692.50768730793, 1000.7648202672366, 1005.2812239248972, 1026.5380578739598, 1027.1885210683477, 1030.0472063341379, 10790.0, 10879.782404351869, 10927.398993055458, 11011.229213954946, 11030.50362733679, 494705.0, 504240.0, 516015.0, 519715.0, 519970.0, 109610.0, 111806.44096779464, 112388.43805780918, 113598.0, 115481.42259288649, 1142.9542818287175, 1155.1682788392345, 1201.8257352683986, 1213.9817902731465, 1215.9878401216051, 20211.292604758764, 20444.795552044885, 20592.69110963307, 20639.380818575468, 20822.375328740163, 59153.40846591479, 60430.39569604248, 60801.39198608134, 61584.69207653933, 62379.0, 76384.0, 76513.23486765061, 76703.0, 77123.0, 77406.6129669348, 14311.856881431053, 14480.637984050483, 14705.264736762905, 14765.114093154016, 14766.852331476977, 22691.773082268966, 22813.543729125657, 22871.542569148856, 23247.41881452977, 23501.41246468852, 17693.734593981357, 18018.36935707244, 18025.549361266072, 18034.0, 18096.90951545234, 16009.599760005627, 16234.918825405797, 16671.249793759067, 16916.15419229009, 16926.40757573479, 18306.450806475827, 18358.908205458887, 18442.35451759182, 18518.907405462887, 18676.81323186805, 14381.712365752835, 14581.489647862698, 14586.4894728684, 14602.269886505845, 14691.338889749773, 17746.0, 17792.822071779636, 18067.45797626073, 18174.72737908959, 18429.354972575897], "value": 12004.861823334151, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.674831292177, 1354.1198221156244, 1368.4457794593186, 1372.8009438631393, 1372.9244891530968, 14353.856461435382, 14851.851481485182, 14873.330700118493, 14895.0, 15053.774193387095, 15003.92498037511, 15299.23503824807, 15309.540713778577, 15333.386664533406, 15344.462943796969, 2717.605947137669, 2815.85920703965, 2822.2238884306776, 2822.7459528642416, 2848.1882663440924, 2710.186943916817, 2804.242854429303, 2822.0828230824964, 2829.8726557304867, 2832.5043117454466, 2662.7337266273316, 2753.7108603596635, 2834.4189441164513, 2845.260232339586, 2854.029629925825, 2805.8737356818788, 2833.404984953152, 2844.6586409630872, 2854.0724264613877, 2864.713528647129, 2654.8672566371797, 2674.318048897538, 2698.298442404969, 2709.065372446503, 2713.511567917774, 14472.493462728755, 14793.186374749384, 14795.852041479555, 14865.851341486556, 14880.255987200597, 7726.266004729542, 8011.8798218026195, 8024.117347091816, 8032.999999999942, 8040.396970227198, 5192.792288308463, 5373.435789242112, 5505.752241149118, 5609.5792815539, 5696.287964004499, 1959.7550306211724, 1975.5456245063715, 1992.3823614679495, 2045.764737055243, 2048.3957232616413, 26038.479230415476, 26127.869360653076, 26311.73688263112, 26336.60495092575, 26375.20874373772, 6770.69531871067, 6843.692033858389, 6893.4829887758615, 7094.6097964612445, 7108.857822843514, 16772.077535735407, 16810.243539040774, 16844.831551684325, 16922.238499267318, 16952.406665766637, 7612.7716168515035, 7728.26581474759, 7740.729074482366, 7755.573443460664, 7788.493747906368, 6962.268961759044, 7051.083359163276, 7059.858802823915, 7136.179339375934, 7255.310745479171, 4966.751662416937, 5112.335396398445, 5177.352830896138, 5198.740062996835, 5199.142141546678, 1317.0912070671206, 1350.9932450337685, 1500.6248437890526, 1501.9711497624162, 1550.7518796992654, 883.5758835758871, 908.0102688069903, 915.5376534849859, 934.2806039349663, 936.7892224249489, 8457.069722330662, 8462.238398544161, 8518.275946544612, 8573.699920502877, 8584.098669639723, 722.3787542713262, 726.3245181980809, 730.8099894027591, 732.3079689693295, 799.7720649614832, 5000.374953130859, 5093.668911520739, 5129.769160387791, 5253.159494480865, 5400.621956463088, 19594.902025490068, 21656.675149872764, 21734.673979890315, 21836.89081554582, 22140.892955352167, 21165.15339386438, 21376.679349809765, 21787.891060544596, 21854.12583496674, 21937.670934935988, 10726.195535334726, 10938.726531836768, 10984.670459886216, 11000.009999100119, 11087.944560277147, 8090.271875531231, 8124.55314957683, 8153.714619988272, 8216.876746848682, 8228.382871284797, 18275.908620456812, 18692.532686682942, 18818.0, 18938.337158199396, 19193.424197274104, 18618.906905465385, 18706.0, 18797.718034229772, 19550.8044919549, 19551.70672439886, 10540.314879532805, 10601.363918164934, 10632.734181645521, 10641.8935810644, 10651.89348106509, 13447.193168409927, 13551.457941682616, 13827.861721382658, 13836.654083647989, 13838.377273022537, 10698.518566664674, 10805.297655652357, 10939.45302734876, 10951.45242737876, 11087.33475991443, 10335.17318614494, 10527.315724477885, 10551.736206594896, 10556.472176390997, 10855.294405863593, 9811.822581290291, 9860.704178874645, 9862.852057219005, 9897.307188496736, 9984.0, 7322.0, 7384.187739348775, 7393.07586551681, 7435.256474352522, 7531.88702169457, 7408.259174082548, 7466.365358944333, 7525.233103434656, 7531.397488201041, 7645.273698998586], "value": 6610.626766519008, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.41918954822853, 510.79568172730905, 536.5486359397828, 541.0936681059225, 544.3223187132019, 6135.0, 6208.751649934008, 6231.750729970801, 6249.0, 6289.591176573519, 6103.115048317991, 6106.0, 6137.938620613792, 6153.846153846156, 6163.476104531109, 5077.187649976005, 5079.1365467870455, 5088.160453525164, 5156.407013193474, 5159.355080614923, 4788.90422191556, 5118.488151184889, 5144.536991670749, 5150.845474635767, 5184.403793563751, 4902.289168070645, 4918.139325618021, 4930.728809915453, 4940.851774446773, 4952.603791696655, 4906.190478571031, 4923.679960802554, 4923.950760492385, 4925.2858335541505, 4933.358663373739, 4312.654987600984, 4419.40338054365, 4435.68950173488, 4444.488883778375, 4445.755483448409, 5992.550558708114, 6006.699665016776, 6010.128531362971, 6033.245844269466, 6071.787487437919, 5623.80316688918, 5628.0, 5631.239782629334, 5649.12438572022, 5660.60375773696, 6372.904406433907, 6409.166808314936, 6424.682939997289, 6445.774397896098, 6455.322191169907, 4635.397398338228, 4795.928061079087, 4859.319695242669, 4860.513948605147, 4870.415550133971, 6478.769033883547, 6575.80272591823, 6648.401643852028, 6700.128983232149, 6817.625030623363, 4928.482509336468, 4955.801767929314, 4971.78191343116, 4972.428170760337, 4982.153033984159, 5027.497250275016, 5044.974775126101, 5048.368953880765, 5057.039162559102, 5065.721385323843, 5522.641028333145, 5634.943650563524, 5636.2954630671165, 5645.181448689917, 5680.517156041783, 6348.841278968062, 6406.231252249667, 6432.388923052303, 6452.9677351612945, 6469.5794773339585, 1711.1957380031365, 1726.214572369569, 1743.686136495443, 1747.816479269684, 1751.2907272554635, 1145.9828102578467, 1194.2535915053093, 1216.6532538226563, 1232.6733415644862, 1237.2020047069589, 5580.776768929279, 5597.832065038056, 5598.748056337475, 5612.923218409214, 5629.268195134607, 6520.93516047457, 6572.4084832365315, 6600.80197594073, 6609.735610575523, 6615.140031795836, 5406.864828379244, 5628.831135065954, 5651.976192736866, 5667.688277144796, 5715.742791574389, 3350.1959529712694, 3402.9791062681097, 3428.6914177724125, 3434.9313013739584, 3438.570178727659, 6287.937120628827, 6350.650714210763, 6354.555181137276, 6367.458766004941, 6369.840753981188, 6522.869542609216, 6624.701888414937, 6626.0784372531425, 6693.226295031723, 6782.253952065269, 6388.584741991755, 6413.3266007069515, 6414.139899429113, 6499.415052645285, 6548.380647740942, 6530.771423000172, 6544.640044797582, 6558.8360290993105, 6679.398854103154, 6682.331766823473, 6437.742490300336, 6495.317991610813, 6541.967290163519, 6589.604623722592, 6615.272320044695, 6245.781397651061, 6386.808395748135, 6398.264199616918, 6446.742130314735, 6535.379138981789, 5042.4705405931845, 5066.771995260296, 5068.467810879804, 5081.161608334583, 5084.542391184811, 6308.814048905273, 6410.839729006812, 6575.947848344242, 6687.765928192684, 6757.932420675927, 6180.4746596538, 6292.150559674568, 6356.841078972878, 6406.583572067801, 6433.485321174388, 6277.717502712298, 6281.183446151971, 6371.203599550056, 6425.518086143465, 6509.349065093642, 6274.309825919054, 6299.6535190564955, 6348.730253949137, 6368.993766963577, 6427.003814408774, 6352.460040896575, 6391.392817682313, 6405.391487808651, 6460.580062295936, 6548.214214294315, 6166.630002199882, 6213.65824879636, 6271.78048768291, 6286.339934307015, 6334.303226644974], "value": 4988.295370857538, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [902.9097090290968, 907.5416914458198, 915.9862602060966, 919.1589695428684, 934.2525979216628, 19166.137523811445, 19769.901150494246, 19823.5044123897, 19828.50428739282, 19943.0, 16690.916545417254, 16732.41436549721, 16827.0, 16869.40957066503, 16870.662586748258, 944.8866136063665, 957.090763774417, 960.13108137136, 961.5721004153155, 966.8694726211977, 969.9951500242524, 977.1352353167426, 978.295627148452, 980.3333733061515, 981.1954197558006, 990.3513198854762, 1028.146638290221, 1028.7736697926443, 1030.294248439821, 1036.2694300518117, 1023.0, 1034.9689509314694, 1039.8648175737105, 1040.0119886108153, 1040.7814358984622, 723.2839488905997, 738.7119023580808, 740.8036870229394, 741.7589283482836, 746.6714645555938, 18249.817501824946, 18884.15021324044, 18957.33649322281, 18987.33544325956, 19782.80217197824, 21447.463813404633, 21467.248646297303, 21704.914754262383, 22212.333629991124, 22390.104395824146, 17325.306987720476, 17556.824431755645, 17622.91188544062, 17636.735448968277, 17762.911185444118, 3628.9274214515563, 3639.890803275906, 3668.5047518584915, 3675.1730860556163, 3675.852965881388, 110732.0, 127163.36418317942, 142011.2899435496, 142702.0, 145347.0, 17721.468355949342, 17764.644707106043, 18059.0, 18089.7286540702, 18119.275228990693, 31276.53085203724, 32017.359652806812, 32312.83843580767, 32382.35235295281, 32503.0, 8803.955980220058, 9097.272218222526, 9103.135202155785, 9147.359684822131, 9181.632734690671, 4302.526722060571, 4368.737875727466, 4390.385346051556, 4414.4702635683925, 4426.468823741172, 5467.617266791366, 5532.225488431623, 5537.556995440355, 5553.083741182741, 5553.805931724618, 1125.2685754259796, 1134.4384529657707, 1135.4663308245113, 1139.0090621159645, 1162.808136657459, 647.3267801486495, 660.1154453032959, 678.1184460201816, 685.0409426802416, 687.1753895325629, 12137.332446715338, 12291.201071930474, 12308.753824923451, 12535.24788512692, 12589.181703189264, 678.2674711311771, 681.9283975182534, 692.7263730826396, 699.0946723992442, 710.2435905760452, 5694.601377903507, 5764.7117644117625, 5816.302043754777, 5845.941540584539, 5889.734961926723, 128515.0, 130081.0, 131806.0, 132656.0, 134784.0, 101049.0, 104501.47749261204, 107393.0, 108219.0, 109389.45305273423, 97640.0, 100154.0, 100724.0, 100905.0, 103048.0, 10628.36229826213, 10706.678799636024, 10903.2367734261, 10998.14834224233, 11038.337699738042, 44473.888152795145, 45144.77427612841, 46433.53566464292, 46818.0, 47313.763431182626, 57630.4236957625, 58309.416905830396, 58660.41339586549, 59508.70245648744, 59703.0, 15210.847891520943, 15746.76379854326, 15925.522234332988, 16077.839221607634, 16117.597060073593, 18137.81862181414, 18205.817941820413, 18225.544361391072, 18320.633587327913, 18400.63198735991, 16089.919550402174, 16141.919290403473, 16285.755713664541, 16296.918515407822, 16378.344866205218, 16156.596085097497, 16270.918645407171, 16443.753343700093, 16577.66844663124, 16740.832591673927, 15036.849631503545, 15227.390904363701, 15281.312340944907, 15313.081215127128, 15353.0, 10371.170306375321, 10509.527071281658, 10609.787804244026, 10690.037896589345, 10695.304805187638, 11862.288262704265, 12099.213551119501, 12115.0, 12145.332006739362, 12175.147739658492], "value": 9012.90026242085, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1440.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 117.0, 116.0, 109.0, 113.0, 108.0, 119.0, 114.0, 109.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 125.0, 131.0, 120.0, 128.0, 117.0, 126.0, 124.0, 116.0, 129.0], "value": 123.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 170.0, 163.0, 162.0, 168.0, 168.0, 168.0, 165.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 80.0, 85.0, 74.0, 73.0, 78.0, 78.0, 81.0, 74.0], "value": 77.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 83.0, 82.0, 86.0, 79.0, 79.0, 79.0, 83.0], "value": 80.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 115.0, 124.0, 112.0, 111.0, 121.0, 113.0, 112.0, 114.0, 111.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 151.0, 150.0, 150.0, 148.0, 149.0, 149.0, 154.0, 147.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 94.0, 96.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 51.0, 53.0, 63.0, 52.0, 55.0, 64.0, 52.0, 50.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [41.0, 43.0, 37.0, 38.0, 38.0, 47.0, 44.0, 41.0, 47.0, 38.0], "value": 41.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 80.0, 75.0, 79.0, 83.0, 78.0, 77.0, 78.0, 74.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 118.0, 114.0, 120.0, 118.0, 113.0, 116.0, 115.0, 116.0, 111.0], "value": 115.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 159.0, 161.0, 165.0, 158.0, 167.0, 171.0, 169.0], "value": 163.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 70.0, 66.0, 65.0, 64.0, 66.0, 67.0, 66.0], "value": 65.2, "unit": "score"}]}]} 02:39:19 INFO - Return code: 0 02:39:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:39:20 INFO - # TBPL SUCCESS # 02:39:20 INFO - Running post-action listener: _package_coverage_data 02:39:20 INFO - Running post-action listener: _resource_record_post_action 02:39:20 INFO - [mozharness: 2017-09-30 09:39:20.054645Z] Finished run-tests step (success) 02:39:20 INFO - Running post-run listener: _resource_record_post_run 02:39:20 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 16060416; Write bytes: 400699392; Read time: 5388; Write time: 266496 02:39:20 INFO - TinderboxPrint: CPU usage
13.2% 02:39:20 INFO - TinderboxPrint: I/O read bytes / time
16,060,416 / 5,388 02:39:20 INFO - TinderboxPrint: I/O write bytes / time
400,699,392 / 266,496 02:39:20 INFO - TinderboxPrint: CPU idle
8,270.2 (86.8%) 02:39:20 INFO - TinderboxPrint: CPU user
1,196.5 (12.6%) 02:39:20 INFO - TinderboxPrint: Swap in / out
0 / 0 02:39:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 75702272; Read time: 0; Write time: 32732 02:39:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:39:20 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 13684736; Write bytes: 257744896; Read time: 4648; Write time: 183312 02:39:20 INFO - Running post-run listener: _upload_blobber_files 02:39:20 INFO - Blob upload gear active. 02:39:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:39:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:39:21 INFO - (blobuploader) - INFO - Open directory for files ... 02:39:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:39:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:22 INFO - (blobuploader) - INFO - Done attempting. 02:39:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:39:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:39:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:23 INFO - (blobuploader) - INFO - Done attempting. 02:39:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:39:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:39:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:27 INFO - (blobuploader) - INFO - Done attempting. 02:39:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:39:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:39:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:39:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:39:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:39:28 INFO - (blobuploader) - INFO - Done attempting. 02:39:28 INFO - (blobuploader) - INFO - Iteration through files over. 02:39:28 INFO - Return code: 0 02:39:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:39:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:39:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5587269670eb40e70d4e6ffa99c84218871b9e7b4b2b5c6b8c11ef179afcf7c3c7841837f1610896c337fcdc8b63b6c3ac905633010209b061b54fbc0c221644", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1faaa6c4b9e0050614da6e5fb4d9817bebed92111e44ea288a0b6c35e5a2bb2b88117675d29e0aa28dad4c2ca0893311ffa26873d867e3905a51cb50fc64d63", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89e1c729b2ea4b6e7fb0ccbd000d4438fb7bdb76e393f9c3ae2b3fb1f9592ad568be7f87bfe522686a1a90876982ed3d7f3a979dbae79effc8a28a3fd1a17c7e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/665d62f0ae5c802b766e9555ac1f88eba52cafc09e063da75b2ad92eb6b5b070844c851501c680c928f9bb8372b970a1cb18c1babf23f811f337cf0dc7d95c73"} 02:39:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:39:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:39:28 INFO - Contents: 02:39:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5587269670eb40e70d4e6ffa99c84218871b9e7b4b2b5c6b8c11ef179afcf7c3c7841837f1610896c337fcdc8b63b6c3ac905633010209b061b54fbc0c221644", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1faaa6c4b9e0050614da6e5fb4d9817bebed92111e44ea288a0b6c35e5a2bb2b88117675d29e0aa28dad4c2ca0893311ffa26873d867e3905a51cb50fc64d63", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89e1c729b2ea4b6e7fb0ccbd000d4438fb7bdb76e393f9c3ae2b3fb1f9592ad568be7f87bfe522686a1a90876982ed3d7f3a979dbae79effc8a28a3fd1a17c7e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/665d62f0ae5c802b766e9555ac1f88eba52cafc09e063da75b2ad92eb6b5b070844c851501c680c928f9bb8372b970a1cb18c1babf23f811f337cf0dc7d95c73"} 02:39:28 INFO - Running post-run listener: copy_logs_to_upload_dir 02:39:28 INFO - Copying logs to upload dir... 02:39:28 INFO - mkdir: /builds/slave/test/build/upload/logs 02:39:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.880008 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-09-30 02:39:28.258042) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-30 02:39:28.261430) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5587269670eb40e70d4e6ffa99c84218871b9e7b4b2b5c6b8c11ef179afcf7c3c7841837f1610896c337fcdc8b63b6c3ac905633010209b061b54fbc0c221644", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1faaa6c4b9e0050614da6e5fb4d9817bebed92111e44ea288a0b6c35e5a2bb2b88117675d29e0aa28dad4c2ca0893311ffa26873d867e3905a51cb50fc64d63", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89e1c729b2ea4b6e7fb0ccbd000d4438fb7bdb76e393f9c3ae2b3fb1f9592ad568be7f87bfe522686a1a90876982ed3d7f3a979dbae79effc8a28a3fd1a17c7e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/665d62f0ae5c802b766e9555ac1f88eba52cafc09e063da75b2ad92eb6b5b070844c851501c680c928f9bb8372b970a1cb18c1babf23f811f337cf0dc7d95c73"} build_url:https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011137 build_url: 'https://queue.taskcluster.net/v1/task/b7fo7CzdTyC6sEI3QK7nvA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5587269670eb40e70d4e6ffa99c84218871b9e7b4b2b5c6b8c11ef179afcf7c3c7841837f1610896c337fcdc8b63b6c3ac905633010209b061b54fbc0c221644", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1faaa6c4b9e0050614da6e5fb4d9817bebed92111e44ea288a0b6c35e5a2bb2b88117675d29e0aa28dad4c2ca0893311ffa26873d867e3905a51cb50fc64d63", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89e1c729b2ea4b6e7fb0ccbd000d4438fb7bdb76e393f9c3ae2b3fb1f9592ad568be7f87bfe522686a1a90876982ed3d7f3a979dbae79effc8a28a3fd1a17c7e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/665d62f0ae5c802b766e9555ac1f88eba52cafc09e063da75b2ad92eb6b5b070844c851501c680c928f9bb8372b970a1cb18c1babf23f811f337cf0dc7d95c73"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-30 02:39:28.291830) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 02:39:28.292363) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1506752005.2490-460506673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 02:39:28.377332) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-30 02:39:28.377913) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-30 02:39:28.378387) ========= ========= Total master_lag: 0.23 =========