builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1505469450.34 results: success (0) revision: 893fe1549e1e7342a66514b65960f08d40810a34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 02:57:30.342118) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 02:57:30.342934) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 02:57:30.343246) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 02:57:30.394595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 02:57:30.394903) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-15 02:57: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2017-09-15 02:57:30 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145300 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 02:57:30.555807) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 02:57:30.556146) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021515 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 02:57:30.605564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 mins, 20 secs) (at 2017-09-15 02:57:30.605928) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 893fe1549e1e7342a66514b65960f08d40810a34 --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 893fe1549e1e7342a66514b65960f08d40810a34 --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=78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-15 02:57:30,657 truncating revision to first 12 chars 2017-09-15 02:57:30,657 Setting DEBUG logging. 2017-09-15 02:57:30,657 attempt 1/10 2017-09-15 02:57:30,657 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/893fe1549e1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-15 02:57:31,791 attempt 1/10 2017-09-15 02:57:32,481 current task status: no status available at this point. state: PENDING 2017-09-15 02:57:32,481 sleeping for 9.00s (attempt 1/10) 2017-09-15 02:57:41,491 attempt 2/10 2017-09-15 02:57:42,081 current task status: no status available at this point. state: PENDING 2017-09-15 02:57:42,081 sleeping for 14.50s (attempt 2/10) 2017-09-15 02:57:56,596 attempt 3/10 2017-09-15 02:57:57,115 current task status: no status available at this point. state: PENDING 2017-09-15 02:57:57,115 sleeping for 20.75s (attempt 3/10) 2017-09-15 02:58:17,886 attempt 4/10 2017-09-15 02:58:18,415 current task status: no status available at this point. state: PENDING 2017-09-15 02:58:18,415 sleeping for 32.12s (attempt 4/10) 2017-09-15 02:58:50,572 attempt 5/10 2017-09-15 02:58:50,932 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-15 02:58:51,111 unpacking tar archive at: mozilla-central-893fe1549e1e/testing/mozharness/ program finished with exit code 0 elapsedTime=80.781558 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 mins, 20 secs) (at 2017-09-15 02:58:51.403213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:51.403548) ========= script_repo_revision: 893fe1549e1e7342a66514b65960f08d40810a34 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:51.403953) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:51.404215) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:51.416886) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-15 02:58:51.417276) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:58:51 INFO - MultiFileLogger online at 20170915 02:58:51 in /builds/slave/test 02:58:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:58:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:58:51 INFO - {'append_to_log': False, 02:58:51 INFO - 'base_work_dir': '/builds/slave/test', 02:58:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:58:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:58:51 INFO - 'branch': 'Firefox-Non-PGO', 02:58:51 INFO - 'buildbot_json_path': 'buildprops.json', 02:58:51 INFO - 'code_coverage': False, 02:58:51 INFO - 'config_files': ('talos/linux_config.py',), 02:58:51 INFO - 'default_actions': ('clobber', 02:58:51 INFO - 'read-buildbot-config', 02:58:51 INFO - 'download-and-extract', 02:58:51 INFO - 'populate-webroot', 02:58:51 INFO - 'create-virtualenv', 02:58:51 INFO - 'install', 02:58:51 INFO - 'setup-mitmproxy', 02:58:51 INFO - 'run-tests'), 02:58:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:58:51 INFO - 'disable_ccov_upload': False, 02:58:51 INFO - 'disable_stylo': False, 02:58:51 INFO - 'download_minidump_stackwalk': True, 02:58:51 INFO - 'download_symbols': 'ondemand', 02:58:51 INFO - 'enable_stylo': False, 02:58:51 INFO - 'enable_webrender': False, 02:58:51 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:58:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:58:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:58:51 INFO - 'gecko_profile': False, 02:58:51 INFO - 'gecko_profile_interval': 0, 02:58:51 INFO - 'installer_path': 'installer.exe', 02:58:51 INFO - 'log_level': 'info', 02:58:51 INFO - 'log_name': 'talos', 02:58:51 INFO - 'log_to_console': True, 02:58:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:58:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:58:51 INFO - 'opt_config_files': (), 02:58:51 INFO - 'pip_index': False, 02:58:51 INFO - 'suite': 'dromaeojs-e10s', 02:58:51 INFO - 'system_bits': '32', 02:58:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:58:51 INFO - 'title': 'talos-linux64-ix-019', 02:58:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:58:51 INFO - 'use_talos_json': True, 02:58:51 INFO - 'verify': 'False', 02:58:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:58:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:58:51 INFO - 'work_dir': 'build'} 02:58:51 INFO - [mozharness: 2017-09-15 09:58:51.615137Z] Running clobber step. 02:58:51 INFO - Running pre-action listener: _resource_record_pre_action 02:58:51 INFO - Running main action method: clobber 02:58:51 INFO - rmtree: /builds/slave/test/build 02:58:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:58:53 INFO - Running post-action listener: _resource_record_post_action 02:58:53 INFO - [mozharness: 2017-09-15 09:58:53.129909Z] Finished clobber step (success) 02:58:53 INFO - [mozharness: 2017-09-15 09:58:53.130006Z] Running read-buildbot-config step. 02:58:53 INFO - Running pre-action listener: _resource_record_pre_action 02:58:53 INFO - Running main action method: read_buildbot_config 02:58:53 INFO - Using buildbot properties: 02:58:53 INFO - { 02:58:53 INFO - "project": "", 02:58:53 INFO - "product": "firefox", 02:58:53 INFO - "who": "archaeopteryx@coole-files.de", 02:58:53 INFO - "installer_path": "public/build/target.tar.bz2", 02:58:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:58:53 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:58:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:58:53 INFO - "stage_platform": "linux64", 02:58:53 INFO - "basedir": "/builds/slave/test", 02:58:53 INFO - "buildnumber": 1151, 02:58:53 INFO - "platform": "ubuntu64_hw", 02:58:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:58:53 INFO - "slavebuilddir": "test", 02:58:53 INFO - "taskId": "Qgu6R6QcRyebg-tVcsNddg", 02:58:53 INFO - "branch": "mozilla-central", 02:58:53 INFO - "script_repo_revision": "production", 02:58:53 INFO - "revision": "893fe1549e1e7342a66514b65960f08d40810a34", 02:58:53 INFO - "slavename": "talos-linux64-ix-019", 02:58:53 INFO - "repo_path": "mozilla-central" 02:58:53 INFO - } 02:58:53 INFO - Finding installer, test and symbols from parent task. 02:58:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qgu6R6QcRyebg-tVcsNddg'}, attempt #1 02:58:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qgu6R6QcRyebg-tVcsNddg'}, attempt #1 02:58:54 INFO - Task dependencies: VYH2wZ13SaWnxkKe49_76g 02:58:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g'}, attempt #1 02:58:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.tar.bz2 02:58:54 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.test_packages.json 02:58:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.crashreporter-symbols.zip 02:58:54 INFO - Running post-action listener: _resource_record_post_action 02:58:54 INFO - [mozharness: 2017-09-15 09:58:54.562048Z] Finished read-buildbot-config step (success) 02:58:54 INFO - [mozharness: 2017-09-15 09:58:54.562265Z] Running download-and-extract step. 02:58:54 INFO - Running pre-action listener: _resource_record_pre_action 02:58:54 INFO - Running main action method: download_and_extract 02:58:54 INFO - mkdir: /builds/slave/test/build/tests 02:58:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:54 INFO - trying https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.test_packages.json 02:58:54 INFO - Downloading https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:58:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:58:55 INFO - Downloaded 989 bytes. 02:58:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:58:55 INFO - Using the following test package requirements: 02:58:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:58:55 INFO - u'common': [u'target.common.tests.zip'], 02:58:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:58:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:58:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:58:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:58:55 INFO - u'mozbase': [u'target.common.tests.zip'], 02:58:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:58:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:58:55 INFO - u'web-platform': [u'target.common.tests.zip', 02:58:55 INFO - u'target.web-platform.tests.tar.gz'], 02:58:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:58:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:58:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.common.tests.zip 02:58:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:58:55 INFO - Fetch https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.common.tests.zip into memory 02:58:56 INFO - Content-Length response header: 54736771 02:58:56 INFO - Bytes received: 54736771 02:59:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.talos.tests.zip 02:59:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:59:06 INFO - Fetch https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.talos.tests.zip into memory 02:59:07 INFO - Content-Length response header: 14502661 02:59:07 INFO - Bytes received: 14502661 02:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:07 INFO - trying https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.tar.bz2 02:59:07 INFO - Downloading https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:59:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:59:09 INFO - Downloaded 61595327 bytes. 02:59:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.tar.bz2 02:59:09 INFO - mkdir: /builds/slave/test/properties 02:59:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:59:09 INFO - Writing to file /builds/slave/test/properties/build_url 02:59:09 INFO - Contents: 02:59:09 INFO - build_url:https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.tar.bz2 02:59:09 INFO - Running post-action listener: _resource_record_post_action 02:59:09 INFO - Running post-action listener: find_tests_for_verification 02:59:09 INFO - Running post-action listener: set_extra_try_arguments 02:59:09 INFO - [mozharness: 2017-09-15 09:59:09.437074Z] Finished download-and-extract step (success) 02:59:09 INFO - [mozharness: 2017-09-15 09:59:09.437176Z] Running populate-webroot step. 02:59:09 INFO - Running pre-action listener: _resource_record_pre_action 02:59:09 INFO - Running main action method: populate_webroot 02:59:09 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:59:09 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:09 INFO - 'tests': ['tresize', 02:59:09 INFO - 'tcanvasmark']}, 02:59:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:59:09 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:09 INFO - 'tests': ['dromaeo_css', 02:59:09 INFO - 'kraken']}, 02:59:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:59:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:09 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:09 INFO - 'talos_options': ['--disable-stylo'], 02:59:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:59:09 INFO - 'tests': ['damp', 'tps']}, 02:59:09 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:09 INFO - 'talos_options': ['--disable-stylo'], 02:59:09 INFO - 'tests': ['damp', 'tps']}, 02:59:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:09 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:09 INFO - 'tests': ['dromaeo_dom']}, 02:59:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:59:09 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:09 INFO - 'tests': ['basic_compositor_video', 02:59:09 INFO - 'glvideo']}, 02:59:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:59:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:59:09 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:09 INFO - 'talos_options': ['--disable-stylo'], 02:59:09 INFO - 'tests': ['ts_paint_webext', 02:59:09 INFO - 'tp5o_webext']}, 02:59:09 INFO - 'other-e10s': {'tests': ['a11yr', 02:59:09 INFO - 'ts_paint', 02:59:09 INFO - 'tpaint', 02:59:09 INFO - 'sessionrestore', 02:59:09 INFO - 'sessionrestore_many_windows', 02:59:09 INFO - 'sessionrestore_no_auto_restore', 02:59:09 INFO - 'tabpaint']}, 02:59:09 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:09 INFO - 'tests': ['a11yr', 02:59:09 INFO - 'ts_paint', 02:59:09 INFO - 'tpaint', 02:59:09 INFO - 'sessionrestore', 02:59:09 INFO - 'sessionrestore_many_windows', 02:59:09 INFO - 'sessionrestore_no_auto_restore', 02:59:09 INFO - 'tabpaint']}, 02:59:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:59:09 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:59:09 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:09 INFO - 'tests': ['bloom_basic_singleton']}, 02:59:09 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:09 INFO - 'tests': ['bloom_basic']}, 02:59:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:59:09 INFO - 'tsvgr_opacity', 02:59:09 INFO - 'tart', 02:59:09 INFO - 'tscrollx', 02:59:09 INFO - 'tsvg_static']}, 02:59:09 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:09 INFO - 'tests': ['tsvgx', 02:59:09 INFO - 'tsvgr_opacity', 02:59:09 INFO - 'tart', 02:59:09 INFO - 'tscrollx', 02:59:09 INFO - 'tsvg_static']}, 02:59:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:59:09 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:09 INFO - 'talos_options': ['--disable-stylo'], 02:59:09 INFO - 'tests': ['tp5o']}, 02:59:09 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:59:09 INFO - 'talos_options': ['--mitmproxy', 02:59:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:59:09 INFO - '--firstNonBlankPaint'], 02:59:09 INFO - 'tests': ['tp6_google', 02:59:09 INFO - 'tp6_youtube', 02:59:09 INFO - 'tp6_amazon', 02:59:09 INFO - 'tp6_facebook']}, 02:59:09 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:59:09 INFO - 'talos_options': ['--disable-stylo', 02:59:09 INFO - '--mitmproxy', 02:59:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:59:09 INFO - '--firstNonBlankPaint'], 02:59:09 INFO - 'tests': ['tp6_google', 02:59:09 INFO - 'tp6_youtube', 02:59:09 INFO - 'tp6_amazon', 02:59:09 INFO - 'tp6_facebook']}, 02:59:09 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:59:09 INFO - 'talos_options': ['--stylo-threads=1', 02:59:09 INFO - '--mitmproxy', 02:59:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:59:09 INFO - '--firstNonBlankPaint'], 02:59:09 INFO - 'tests': ['tp6_google', 02:59:09 INFO - 'tp6_youtube', 02:59:09 INFO - 'tp6_amazon', 02:59:09 INFO - 'tp6_facebook']}, 02:59:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:59:09 INFO - 'talos_options': ['--xperf_path', 02:59:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:09 INFO - 'tests': ['tp5n']}, 02:59:09 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:09 INFO - 'talos_options': ['--disable-stylo', 02:59:09 INFO - '--xperf_path', 02:59:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:09 INFO - 'tests': ['tp5n']}}} 02:59:09 INFO - Running post-action listener: _resource_record_post_action 02:59:09 INFO - [mozharness: 2017-09-15 09:59:09.460194Z] Finished populate-webroot step (success) 02:59:09 INFO - [mozharness: 2017-09-15 09:59:09.460283Z] Running create-virtualenv step. 02:59:09 INFO - Running pre-action listener: _resource_record_pre_action 02:59:09 INFO - Running main action method: create_virtualenv 02:59:09 INFO - Creating virtualenv /builds/slave/test/build/venv 02:59:09 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:59:09 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:59:09 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:59:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:59:10 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:10 INFO - Installing pip...............done. 02:59:10 INFO - Return code: 0 02:59:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:59:10 INFO - Reading from file tmpfile_stdout 02:59:10 INFO - Output received: 02:59:10 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:59:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:59: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:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59: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:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79090>, '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 0x2b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', '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:59: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', 'pip>=1.5'] in /builds/slave/test/build 02:59: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 pip>=1.5 02:59:10 INFO - Using env: {'DISPLAY': ':0', 02:59:10 INFO - 'HOME': '/home/cltbld', 02:59:10 INFO - 'LANG': 'en_US.UTF-8', 02:59:10 INFO - 'LANGUAGE': 'en_US:en', 02:59:10 INFO - 'LOGNAME': 'cltbld', 02:59:10 INFO - 'MAIL': '/var/mail/cltbld', 02:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:10 INFO - 'MOZ_NO_REMOTE': '1', 02:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:10 INFO - 'NO_EM_RESTART': '1', 02:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:10 INFO - 'PWD': '/builds/slave/test', 02:59:10 INFO - 'SHELL': '/bin/bash', 02:59:10 INFO - 'SHLVL': '1', 02:59:10 INFO - 'TERM': 'linux', 02:59:10 INFO - 'TMOUT': '86400', 02:59:10 INFO - 'USER': 'cltbld', 02:59:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', 02:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:10 INFO - '_': '/tools/buildbot/bin/python'} 02:59:11 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:59:11 INFO - Downloading/unpacking pip>=1.5 02:59:11 INFO - Running setup.py egg_info for package pip 02:59:11 INFO - warning: no files found matching 'pip/cacert.pem' 02:59:11 INFO - warning: no files found matching '*.html' under directory 'docs' 02:59:11 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:59:11 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:59:11 INFO - Installing collected packages: pip 02:59:11 INFO - Found existing installation: pip 1.1 02:59:11 INFO - Uninstalling pip: 02:59:11 INFO - Successfully uninstalled pip 02:59:11 INFO - Running setup.py install for pip 02:59:11 INFO - warning: no files found matching 'pip/cacert.pem' 02:59:11 INFO - warning: no files found matching '*.html' under directory 'docs' 02:59:11 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:59:11 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:59:11 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:59:11 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:59:11 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:59:11 INFO - Successfully installed pip 02:59:11 INFO - Cleaning up... 02:59:11 INFO - Return code: 0 02:59:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79090>, '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 0x2b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', '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:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:59:11 INFO - Using env: {'DISPLAY': ':0', 02:59:11 INFO - 'HOME': '/home/cltbld', 02:59:11 INFO - 'LANG': 'en_US.UTF-8', 02:59:11 INFO - 'LANGUAGE': 'en_US:en', 02:59:11 INFO - 'LOGNAME': 'cltbld', 02:59:11 INFO - 'MAIL': '/var/mail/cltbld', 02:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:11 INFO - 'MOZ_NO_REMOTE': '1', 02:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:11 INFO - 'NO_EM_RESTART': '1', 02:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:11 INFO - 'PWD': '/builds/slave/test', 02:59:11 INFO - 'SHELL': '/bin/bash', 02:59:11 INFO - 'SHLVL': '1', 02:59:11 INFO - 'TERM': 'linux', 02:59:11 INFO - 'TMOUT': '86400', 02:59:11 INFO - 'USER': 'cltbld', 02:59:11 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', 02:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:11 INFO - '_': '/tools/buildbot/bin/python'} 02:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:11 INFO - Downloading/unpacking psutil>=3.1.1 02:59: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:59: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:59: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:59: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:59:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:13 INFO - Installing collected packages: psutil 02:59:13 INFO - Running setup.py install for psutil 02:59:13 INFO - building 'psutil._psutil_linux' extension 02:59:13 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:59:13 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:59:13 INFO - building 'psutil._psutil_posix' extension 02:59:13 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:59:13 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:59:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:13 INFO - Successfully installed psutil 02:59:13 INFO - Cleaning up... 02:59:13 INFO - Return code: 0 02:59:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79090>, '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 0x2b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', '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:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:59:13 INFO - Using env: {'DISPLAY': ':0', 02:59:13 INFO - 'HOME': '/home/cltbld', 02:59:13 INFO - 'LANG': 'en_US.UTF-8', 02:59:13 INFO - 'LANGUAGE': 'en_US:en', 02:59:13 INFO - 'LOGNAME': 'cltbld', 02:59:13 INFO - 'MAIL': '/var/mail/cltbld', 02:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:13 INFO - 'MOZ_NO_REMOTE': '1', 02:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:13 INFO - 'NO_EM_RESTART': '1', 02:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:13 INFO - 'PWD': '/builds/slave/test', 02:59:13 INFO - 'SHELL': '/bin/bash', 02:59:13 INFO - 'SHLVL': '1', 02:59:13 INFO - 'TERM': 'linux', 02:59:13 INFO - 'TMOUT': '86400', 02:59:13 INFO - 'USER': 'cltbld', 02:59:13 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', 02:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:13 INFO - '_': '/tools/buildbot/bin/python'} 02:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:59: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:59: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:59: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:59: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:59:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:59:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:59:15 INFO - Installing collected packages: mozsystemmonitor 02:59:15 INFO - Running setup.py install for mozsystemmonitor 02:59:15 INFO - Successfully installed mozsystemmonitor 02:59:15 INFO - Cleaning up... 02:59:15 INFO - Return code: 0 02:59:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:59:15 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:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:15 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:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:15 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 0x28091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79090>, '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 0x2b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', '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:59:15 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:59:15 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:59:15 INFO - Using env: {'DISPLAY': ':0', 02:59:15 INFO - 'HOME': '/home/cltbld', 02:59:15 INFO - 'LANG': 'en_US.UTF-8', 02:59:15 INFO - 'LANGUAGE': 'en_US:en', 02:59:15 INFO - 'LOGNAME': 'cltbld', 02:59:15 INFO - 'MAIL': '/var/mail/cltbld', 02:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:15 INFO - 'MOZ_NO_REMOTE': '1', 02:59:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:15 INFO - 'NO_EM_RESTART': '1', 02:59:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:15 INFO - 'PWD': '/builds/slave/test', 02:59:15 INFO - 'SHELL': '/bin/bash', 02:59:15 INFO - 'SHLVL': '1', 02:59:15 INFO - 'TERM': 'linux', 02:59:15 INFO - 'TMOUT': '86400', 02:59:15 INFO - 'USER': 'cltbld', 02:59:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', 02:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:15 INFO - '_': '/tools/buildbot/bin/python'} 02:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:15 INFO - Downloading/unpacking jsonschema==2.5.1 02:59:15 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:59:15 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:59:15 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:59:15 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:59:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:59:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:59:17 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:59:17 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:59:17 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:59:17 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:59:17 INFO - Downloading functools32-3.2.3-2.tar.gz 02:59:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:59:17 INFO - warning: no files found matching '*.txt' 02:59:17 INFO - no previously-included directories found matching 'build' 02:59:17 INFO - no previously-included directories found matching 'dist' 02:59:17 INFO - no previously-included directories found matching '.git*' 02:59:17 INFO - Installing collected packages: jsonschema, functools32 02:59:17 INFO - Running setup.py install for functools32 02:59:17 INFO - warning: no files found matching '*.txt' 02:59:17 INFO - no previously-included directories found matching 'build' 02:59:17 INFO - no previously-included directories found matching 'dist' 02:59:17 INFO - no previously-included directories found matching '.git*' 02:59:17 INFO - Successfully installed jsonschema functools32 02:59:17 INFO - Cleaning up... 02:59:17 INFO - Return code: 0 02:59:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:59: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:59:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59: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:59:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:17 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 0x28091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79090>, '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 0x2b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', '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:59:17 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:59:17 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:59:17 INFO - Using env: {'DISPLAY': ':0', 02:59:17 INFO - 'HOME': '/home/cltbld', 02:59:17 INFO - 'LANG': 'en_US.UTF-8', 02:59:17 INFO - 'LANGUAGE': 'en_US:en', 02:59:17 INFO - 'LOGNAME': 'cltbld', 02:59:17 INFO - 'MAIL': '/var/mail/cltbld', 02:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:17 INFO - 'MOZ_NO_REMOTE': '1', 02:59:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:17 INFO - 'NO_EM_RESTART': '1', 02:59:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:17 INFO - 'PWD': '/builds/slave/test', 02:59:17 INFO - 'SHELL': '/bin/bash', 02:59:17 INFO - 'SHLVL': '1', 02:59:17 INFO - 'TERM': 'linux', 02:59:17 INFO - 'TMOUT': '86400', 02:59:17 INFO - 'USER': 'cltbld', 02:59:17 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', 02:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:17 INFO - '_': '/tools/buildbot/bin/python'} 02:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:59:18 INFO - Cleaning up... 02:59:18 INFO - Return code: 0 02:59:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:59:18 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:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:18 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:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:18 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 0x28091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79090>, '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 0x2b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', '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:59:18 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:59:18 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:59:18 INFO - Using env: {'DISPLAY': ':0', 02:59:18 INFO - 'HOME': '/home/cltbld', 02:59:18 INFO - 'LANG': 'en_US.UTF-8', 02:59:18 INFO - 'LANGUAGE': 'en_US:en', 02:59:18 INFO - 'LOGNAME': 'cltbld', 02:59:18 INFO - 'MAIL': '/var/mail/cltbld', 02:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:18 INFO - 'MOZ_NO_REMOTE': '1', 02:59:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:18 INFO - 'NO_EM_RESTART': '1', 02:59:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:18 INFO - 'PWD': '/builds/slave/test', 02:59:18 INFO - 'SHELL': '/bin/bash', 02:59:18 INFO - 'SHLVL': '1', 02:59:18 INFO - 'TERM': 'linux', 02:59:18 INFO - 'TMOUT': '86400', 02:59:18 INFO - 'USER': 'cltbld', 02:59:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', 02:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:18 INFO - '_': '/tools/buildbot/bin/python'} 02:59:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:18 INFO - Downloading/unpacking blobuploader==1.2.4 02:59:18 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:59:18 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:59:18 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:59:18 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:59:19 INFO - Downloading blobuploader-1.2.4.tar.gz 02:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:59:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:59: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:59: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:59: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:59: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:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:59:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:59: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:59: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:59: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:59: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:59:19 INFO - Downloading docopt-0.6.1.tar.gz 02:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:59:19 INFO - Installing collected packages: blobuploader, requests, docopt 02:59:19 INFO - Running setup.py install for blobuploader 02:59:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:59:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:59:20 INFO - Running setup.py install for requests 02:59:20 INFO - Running setup.py install for docopt 02:59:20 INFO - Successfully installed blobuploader requests docopt 02:59:20 INFO - Cleaning up... 02:59:20 INFO - Return code: 0 02:59:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59: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:59:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59: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:59:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:20 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 0x28091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79090>, '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 0x2b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', '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:59:20 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:59:20 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:59:20 INFO - Using env: {'DISPLAY': ':0', 02:59:20 INFO - 'HOME': '/home/cltbld', 02:59:20 INFO - 'LANG': 'en_US.UTF-8', 02:59:20 INFO - 'LANGUAGE': 'en_US:en', 02:59:20 INFO - 'LOGNAME': 'cltbld', 02:59:20 INFO - 'MAIL': '/var/mail/cltbld', 02:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:20 INFO - 'MOZ_NO_REMOTE': '1', 02:59:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:20 INFO - 'NO_EM_RESTART': '1', 02:59:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:20 INFO - 'PWD': '/builds/slave/test', 02:59:20 INFO - 'SHELL': '/bin/bash', 02:59:20 INFO - 'SHLVL': '1', 02:59:20 INFO - 'TERM': 'linux', 02:59:20 INFO - 'TMOUT': '86400', 02:59:20 INFO - 'USER': 'cltbld', 02:59:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', 02:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:20 INFO - '_': '/tools/buildbot/bin/python'} 02:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:20 INFO - Running setup.py (path:/tmp/pip-K86mhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:20 INFO - Running setup.py (path:/tmp/pip-OHs04C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:20 INFO - Running setup.py (path:/tmp/pip-eOnRPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:20 INFO - Running setup.py (path:/tmp/pip-cBuiP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:21 INFO - Running setup.py (path:/tmp/pip-jj10yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:21 INFO - Running setup.py (path:/tmp/pip-E68C1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:21 INFO - Running setup.py (path:/tmp/pip-oevN70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:21 INFO - Running setup.py (path:/tmp/pip-jgdlb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:21 INFO - Running setup.py (path:/tmp/pip-X_7O6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:21 INFO - Running setup.py (path:/tmp/pip-K9ahdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:21 INFO - Running setup.py (path:/tmp/pip-WyC3Yv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:21 INFO - Running setup.py (path:/tmp/pip-WoTmjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:21 INFO - Running setup.py (path:/tmp/pip-uq8Rqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:21 INFO - Running setup.py (path:/tmp/pip-I6vHBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:21 INFO - Running setup.py (path:/tmp/pip-q9jOA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:21 INFO - Running setup.py (path:/tmp/pip-8_BD8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:21 INFO - Running setup.py (path:/tmp/pip-4okevQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:59:21 INFO - Running setup.py install for manifestparser 02:59:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:59:22 INFO - Running setup.py install for mozcrash 02:59:22 INFO - Running setup.py install for mozdebug 02:59:22 INFO - Running setup.py install for mozdevice 02:59:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:59:22 INFO - Running setup.py install for mozfile 02:59:22 INFO - Running setup.py install for mozhttpd 02:59:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:59:22 INFO - Running setup.py install for mozinfo 02:59:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:59:22 INFO - Running setup.py install for mozInstall 02:59:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:59:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:59:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:59:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:59:22 INFO - Running setup.py install for mozleak 02:59:22 INFO - Running setup.py install for mozlog 02:59:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:59:23 INFO - Running setup.py install for moznetwork 02:59:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:59:23 INFO - Running setup.py install for mozprocess 02:59:23 INFO - Running setup.py install for mozprofile 02:59:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:59:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:59:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:59:23 INFO - Running setup.py install for mozrunner 02:59:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:59:23 INFO - Running setup.py install for mozscreenshot 02:59:23 INFO - Running setup.py install for moztest 02:59:23 INFO - Running setup.py install for mozversion 02:59:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:59:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:59:23 INFO - Cleaning up... 02:59:23 INFO - Return code: 0 02:59:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59: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:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59: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:59:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:23 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 0x28091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79090>, '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 0x2b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', '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:59:23 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:59:23 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:59:23 INFO - Using env: {'DISPLAY': ':0', 02:59:23 INFO - 'HOME': '/home/cltbld', 02:59:23 INFO - 'LANG': 'en_US.UTF-8', 02:59:23 INFO - 'LANGUAGE': 'en_US:en', 02:59:23 INFO - 'LOGNAME': 'cltbld', 02:59:23 INFO - 'MAIL': '/var/mail/cltbld', 02:59:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:23 INFO - 'MOZ_NO_REMOTE': '1', 02:59:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:23 INFO - 'NO_EM_RESTART': '1', 02:59:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:23 INFO - 'PWD': '/builds/slave/test', 02:59:23 INFO - 'SHELL': '/bin/bash', 02:59:23 INFO - 'SHLVL': '1', 02:59:23 INFO - 'TERM': 'linux', 02:59:23 INFO - 'TMOUT': '86400', 02:59:23 INFO - 'USER': 'cltbld', 02:59:23 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', 02:59:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:23 INFO - '_': '/tools/buildbot/bin/python'} 02:59:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:23 INFO - Running setup.py (path:/tmp/pip-EkZU3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:24 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:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:24 INFO - Running setup.py (path:/tmp/pip-LXM9Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:24 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:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:24 INFO - Running setup.py (path:/tmp/pip-gaZD8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:24 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:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:24 INFO - Running setup.py (path:/tmp/pip-bv1jQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:24 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:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:24 INFO - Running setup.py (path:/tmp/pip-Pw5qM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:24 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:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:24 INFO - Running setup.py (path:/tmp/pip-MBJfXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:24 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:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:24 INFO - Running setup.py (path:/tmp/pip-L4_y4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:24 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:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:24 INFO - Running setup.py (path:/tmp/pip-p_Kp5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:24 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:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:24 INFO - Running setup.py (path:/tmp/pip-q76DS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:24 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:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:24 INFO - Running setup.py (path:/tmp/pip-JjSNxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:24 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:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:24 INFO - Running setup.py (path:/tmp/pip-sozT7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:24 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:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:24 INFO - Running setup.py (path:/tmp/pip-Czdmx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:24 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:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:24 INFO - Running setup.py (path:/tmp/pip-MNgmid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:24 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:59:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:24 INFO - Running setup.py (path:/tmp/pip-mnHaVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:25 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:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:25 INFO - Running setup.py (path:/tmp/pip-hoxYIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:25 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:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:25 INFO - Running setup.py (path:/tmp/pip-BPC7u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:25 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:59:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:25 INFO - Running setup.py (path:/tmp/pip-Ed1Aij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:25 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:59:25 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:59:25 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:59:25 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:59:25 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:59:25 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:59:25 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:59:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:59:25 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:59:25 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:59:25 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:59:25 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:59:26 INFO - Downloading blessings-1.6.tar.gz 02:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:59:26 INFO - Installing collected packages: blessings 02:59:26 INFO - Running setup.py install for blessings 02:59:26 INFO - Successfully installed blessings 02:59:26 INFO - Cleaning up... 02:59:26 INFO - Return code: 0 02:59:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:59:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:26 INFO - Reading from file tmpfile_stdout 02:59:26 INFO - Current package versions: 02:59:26 INFO - argparse == 1.2.1 02:59:26 INFO - blessings == 1.6 02:59:26 INFO - blobuploader == 1.2.4 02:59:26 INFO - docopt == 0.6.1 02:59:26 INFO - functools32 == 3.2.3-2 02:59:26 INFO - jsonschema == 2.5.1 02:59:26 INFO - manifestparser == 1.1 02:59:26 INFO - mozInstall == 1.13 02:59:26 INFO - mozcrash == 1.0 02:59:26 INFO - mozdebug == 0.1 02:59:26 INFO - mozdevice == 0.51 02:59:26 INFO - mozfile == 1.2 02:59:26 INFO - mozhttpd == 0.7 02:59:26 INFO - mozinfo == 0.10 02:59:26 INFO - mozleak == 0.1 02:59:26 INFO - mozlog == 3.5 02:59:26 INFO - moznetwork == 0.27 02:59:26 INFO - mozprocess == 0.25 02:59:26 INFO - mozprofile == 0.28 02:59:26 INFO - mozrunner == 6.13 02:59:26 INFO - mozscreenshot == 0.1 02:59:26 INFO - mozsystemmonitor == 0.3 02:59:26 INFO - moztest == 0.8 02:59:26 INFO - mozversion == 1.4 02:59:26 INFO - psutil == 3.1.1 02:59:26 INFO - requests == 1.2.3 02:59:26 INFO - wsgiref == 0.1.2 02:59:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:26 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 0x28091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79090>, '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 0x2b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', '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:59:26 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:59:26 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:59:26 INFO - Using env: {'DISPLAY': ':0', 02:59:26 INFO - 'HOME': '/home/cltbld', 02:59:26 INFO - 'LANG': 'en_US.UTF-8', 02:59:26 INFO - 'LANGUAGE': 'en_US:en', 02:59:26 INFO - 'LOGNAME': 'cltbld', 02:59:26 INFO - 'MAIL': '/var/mail/cltbld', 02:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:26 INFO - 'MOZ_NO_REMOTE': '1', 02:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:26 INFO - 'NO_EM_RESTART': '1', 02:59:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:26 INFO - 'PWD': '/builds/slave/test', 02:59:26 INFO - 'SHELL': '/bin/bash', 02:59:26 INFO - 'SHLVL': '1', 02:59:26 INFO - 'TERM': 'linux', 02:59:26 INFO - 'TMOUT': '86400', 02:59:26 INFO - 'USER': 'cltbld', 02:59:26 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', 02:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:26 INFO - '_': '/tools/buildbot/bin/python'} 02:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:26 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:59:26 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:59:26 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:59:26 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:59:26 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:59:26 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:59:26 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:59:26 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:59:26 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:59:26 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:59:26 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:59:26 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:59:26 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:59:26 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:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:59:28 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:59:28 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:59:28 INFO - Installing collected packages: simplejson 02:59:28 INFO - Running setup.py install for simplejson 02:59:28 INFO - building 'simplejson._speedups' extension 02:59:28 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:59:29 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:59:29 INFO - Successfully installed simplejson 02:59:29 INFO - Cleaning up... 02:59:29 INFO - Return code: 0 02:59:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:59:29 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:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:29 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:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:29 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 0x28091f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b75a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b79090>, '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 0x2b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73f90>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', '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:59:29 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:59:29 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:59:29 INFO - Using env: {'DISPLAY': ':0', 02:59:29 INFO - 'HOME': '/home/cltbld', 02:59:29 INFO - 'LANG': 'en_US.UTF-8', 02:59:29 INFO - 'LANGUAGE': 'en_US:en', 02:59:29 INFO - 'LOGNAME': 'cltbld', 02:59:29 INFO - 'MAIL': '/var/mail/cltbld', 02:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:29 INFO - 'MOZ_NO_REMOTE': '1', 02:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:29 INFO - 'NO_EM_RESTART': '1', 02:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:29 INFO - 'PWD': '/builds/slave/test', 02:59:29 INFO - 'SHELL': '/bin/bash', 02:59:29 INFO - 'SHLVL': '1', 02:59:29 INFO - 'TERM': 'linux', 02:59:29 INFO - 'TMOUT': '86400', 02:59:29 INFO - 'USER': 'cltbld', 02:59:29 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', 02:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:29 INFO - '_': '/tools/buildbot/bin/python'} 02:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:59:29 INFO - Cleaning up... 02:59:29 INFO - Return code: 0 02:59:29 INFO - Running post-action listener: _resource_record_post_action 02:59:29 INFO - Running post-action listener: _start_resource_monitoring 02:59:29 INFO - Starting resource monitoring. 02:59:29 INFO - [mozharness: 2017-09-15 09:59:29.462175Z] Finished create-virtualenv step (success) 02:59:29 INFO - [mozharness: 2017-09-15 09:59:29.462762Z] Running install step. 02:59:29 INFO - Running pre-action listener: _resource_record_pre_action 02:59:29 INFO - Running main action method: install 02:59:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:29 INFO - Reading from file tmpfile_stdout 02:59:29 INFO - Detecting whether we're running mozinstall >=1.0... 02:59:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:59:29 INFO - Reading from file tmpfile_stdout 02:59:29 INFO - Output received: 02:59:29 INFO - Usage: mozinstall [options] installer 02:59:29 INFO - Options: 02:59:29 INFO - -h, --help show this help message and exit 02:59:29 INFO - -d DEST, --destination=DEST 02:59:29 INFO - Directory to install application into. [default: 02:59:29 INFO - "/builds/slave/test"] 02:59:29 INFO - --app=APP Application being installed. [default: firefox] 02:59:29 INFO - mkdir: /builds/slave/test/build/application 02:59:29 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:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:59:47 INFO - Reading from file tmpfile_stdout 02:59:47 INFO - Output received: 02:59:47 INFO - /builds/slave/test/build/application/firefox/firefox 02:59:47 INFO - Running post-action listener: _resource_record_post_action 02:59:47 INFO - [mozharness: 2017-09-15 09:59:47.623178Z] Finished install step (success) 02:59:47 INFO - [mozharness: 2017-09-15 09:59:47.623430Z] Running setup-mitmproxy step. 02:59:47 INFO - Running pre-action listener: _resource_record_pre_action 02:59:47 INFO - Running main action method: setup_mitmproxy 02:59:47 INFO - Skipping: mitmproxy is not required 02:59:47 INFO - Running post-action listener: _resource_record_post_action 02:59:47 INFO - [mozharness: 2017-09-15 09:59:47.624553Z] Finished setup-mitmproxy step (success) 02:59:47 INFO - [mozharness: 2017-09-15 09:59:47.624773Z] Running run-tests step. 02:59:47 INFO - Running pre-action listener: _resource_record_pre_action 02:59:47 INFO - Running pre-action listener: _set_gcov_prefix 02:59:47 INFO - Running main action method: run_tests 02:59:47 WARNING - Try message not found. 02:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:59:47 INFO - Python 2.7.3 02:59:47 INFO - Return code: 0 02:59:47 INFO - grabbing minidump binary from tooltool 02:59: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:59:47 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 0x2b79090>, '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 0x2b79d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b73f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:59:47 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:59:47 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:59:47 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:59:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:59:47 INFO - Return code: 0 02:59:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:59:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:59:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:59:47 INFO - ENV: RUST_BACKTRACE is now full 02:59:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:59:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-019 --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:59:47 INFO - Using env: {'DISPLAY': ':0', 02:59:47 INFO - 'HOME': '/home/cltbld', 02:59:47 INFO - 'LANG': 'en_US.UTF-8', 02:59:47 INFO - 'LANGUAGE': 'en_US:en', 02:59:47 INFO - 'LOGNAME': 'cltbld', 02:59:47 INFO - 'MAIL': '/var/mail/cltbld', 02:59:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:59:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:47 INFO - 'MOZ_NO_REMOTE': '1', 02:59:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:47 INFO - 'NO_EM_RESTART': '1', 02:59:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:47 INFO - 'PWD': '/builds/slave/test', 02:59:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:59:47 INFO - 'RUST_BACKTRACE': 'full', 02:59:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:59:47 INFO - 'SHELL': '/bin/bash', 02:59:47 INFO - 'SHLVL': '1', 02:59:47 INFO - 'TERM': 'linux', 02:59:47 INFO - 'TMOUT': '86400', 02:59:47 INFO - 'USER': 'cltbld', 02:59:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', 02:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:47 INFO - '_': '/tools/buildbot/bin/python'} 02:59:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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:59:48 INFO - mozversion application_buildid: 20170915090610 02:59:48 INFO - mozversion application_changeset: 893fe1549e1e7342a66514b65960f08d40810a34 02:59:48 INFO - mozversion application_display_name: Nightly 02:59:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:59:48 INFO - mozversion application_name: Firefox 02:59:48 INFO - mozversion application_remotingname: firefox 02:59:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:59:48 INFO - mozversion application_vendor: Mozilla 02:59:48 INFO - mozversion application_version: 57.0a1 02:59:48 INFO - mozversion platform_buildid: 20170915090610 02:59:48 INFO - mozversion platform_changeset: 893fe1549e1e7342a66514b65960f08d40810a34 02:59:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:59:48 INFO - mozversion platform_version: 57.0a1 02:59:48 INFO - using testdate: 1505469587 02:59:48 INFO - actual date: 1505469587 02:59:48 INFO - starting webserver on 'localhost:39279' 02:59:48 INFO - SUITE-START | Running 2 tests 02:59:48 INFO - TEST-START | dromaeo_css 02:59:48 INFO - Initialising browser for dromaeo_css test... 02:59:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39279/getInfo.html -profile /tmp/tmpy2Qa1q/profile 02:59:48 INFO - TEST-INFO | started process 31538 (/builds/slave/test/build/application/firefox/firefox http://localhost:39279/getInfo.html) 02:59:54 INFO - TEST-INFO | 31538: exit 0 02:59:54 INFO - Browser initialized. 02:59:54 INFO - Running cycle 1/1 for dromaeo_css test... 02:59:54 INFO - Using env: {'DISPLAY': ':0', 02:59:54 INFO - 'HOME': '/home/cltbld', 02:59:54 INFO - 'JSGC_DISABLE_POISONING': '1', 02:59:54 INFO - 'LANG': 'en_US.UTF-8', 02:59:54 INFO - 'LANGUAGE': 'en_US:en', 02:59:54 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:59:54 INFO - 'LOGNAME': 'cltbld', 02:59:54 INFO - 'MAIL': '/var/mail/cltbld', 02:59:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:59:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:59:54 INFO - 'MOZ_CRASHREPORTER': '1', 02:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:54 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:59:54 INFO - 'MOZ_NO_REMOTE': '1', 02:59:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:54 INFO - 'NO_EM_RESTART': '1', 02:59:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:54 INFO - 'PWD': '/builds/slave/test', 02:59:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:59:54 INFO - 'RUST_BACKTRACE': 'full', 02:59:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:59:54 INFO - 'SHELL': '/bin/bash', 02:59:54 INFO - 'SHLVL': '1', 02:59:54 INFO - 'TERM': 'linux', 02:59:54 INFO - 'TMOUT': '86400', 02:59:54 INFO - 'USER': 'cltbld', 02:59:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', 02:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:54 INFO - '_': '/tools/buildbot/bin/python'} 02:59:54 INFO - TEST-INFO | started process 31775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy2Qa1q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:59:55 INFO - PID 31775 | 02:59:55 INFO - PID 31775 | (/builds/slave/test/build/application/firefox/firefox:31825): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:59:55 INFO - PID 31775 | 03:00:05 INFO - PID 31775 | RSS: Main: 171417600 03:00:05 INFO - PID 31775 | 03:03:03 INFO - PID 31775 | Cycle 1(1): loaded http://localhost:39279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39279/tests/dromaeo/cssquery-ext.html) 03:03:04 INFO - PID 31775 | RSS: Main: 175648768 03:03:04 INFO - PID 31775 | 03:06:06 INFO - PID 31775 | Cycle 1(1): loaded http://localhost:39279/tests/dromaeo/cssquery-ext.html (next: http://localhost:39279/tests/dromaeo/cssquery-jquery.html) 03:06:07 INFO - PID 31775 | RSS: Main: 171540480 03:06:07 INFO - PID 31775 | 03:09:09 INFO - PID 31775 | Cycle 1(1): loaded http://localhost:39279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39279/tests/dromaeo/cssquery-mootools.html) 03:09:09 INFO - PID 31775 | RSS: Main: 173453312 03:09:09 INFO - PID 31775 | 03:12:11 INFO - PID 31775 | Cycle 1(1): loaded http://localhost:39279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39279/tests/dromaeo/cssquery-prototype.html) 03:12:12 INFO - PID 31775 | RSS: Main: 172818432 03:12:12 INFO - PID 31775 | 03:15:15 INFO - PID 31775 | Cycle 1(1): loaded http://localhost:39279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39279/tests/dromaeo/cssquery-yui.html) 03:15:15 INFO - PID 31775 | RSS: Main: 173723648 03:15:15 INFO - PID 31775 | 03:18:17 INFO - PID 31775 | Cycle 1(1): loaded http://localhost:39279/tests/dromaeo/cssquery-yui.html (next: http://localhost:39279/tests/dromaeo/cssquery-dojo.html) 03:18:17 INFO - PID 31775 | RSS: Main: 176988160 03:18:17 INFO - PID 31775 | 03:18:17 INFO - PID 31775 | __start_tp_report 03:18:17 INFO - PID 31775 | _x_x_mozilla_page_load 03:18:17 INFO - PID 31775 | _x_x_mozilla_page_load_details 03:18:17 INFO - PID 31775 | |i|pagename|runs| 03:18:17 INFO - PID 31775 | |0;dojo.html;3151.259454028303;3156.100511354263;3169.7622678299126;3183.029176101288;3227.467467867802;6142.938570614292;6270;6350.174477317948;6365.363463653638;6438.549301548894;6261.561690681654;6295.118683384329;6411.711472983715;6428.646424446653;6438.774642887488;5711.600187986843;5796.768129274824;5846.2107615472005;5846.415358464141;5905.232319798421;5780.1907732917425;5800.941990580082;5848.298204215479;5861.912071318934;5885.8822823543505;5592.692401917893;5693.829185124411;5714.742836572344;5754;5779.393163717791;5659.717014149276;5762.481376676077;5763.510101641324;5783.913241301384;5813;5663.886722265532;5753.741081651336;5773.88452230953;5788.739506722208;5838.5329173666005;6183.907241391383;6246.687665616746;6251.249850018027;6354.904676429857;6382.393672601142;6654.534182607219;6724.159480064992;6741.359570840762;6788.287229840845;6789.592624442549;6754.8311292217595;6827.5562088464585;6850.349216824394;6858.794236172923;6868.072810170613;6106.633601983851;6129.233845769279;6156.969215153896;6359.904601430982;6376.171097757308;7031.7890463286185;7067.89398159028;7073.646317684095;7075.2217256101785;7081.150261968597;6641.335866413417;6645.06969024337;6671.33286671329;6742.49431292655;6751.25736169021;6483.994980777987;6573.539852210395;6734.191896972395;6805.93194068053;6812.216595091529;6764.932350676529;6768.120144381199;6775.796726098225;6778.389944904982;6781.6270105144695;6797.116374871334;6832.6925288362145;6856.280090590416;6863.622500762506;6872.965635171792;5303;5319.707416092075;5363.410024897258;5381.650192737459;5383.488568585978;4485;4569.565891240327;4579.923717926285;4589.885252868638;4667.649926255476;5819.88360232793;5833.300003999547;5838.9124163137585;5867.413258674099;5890.263717035371;6736.696848641823;6821.556598821061;6887.173539175331;6900.551464154814;6915.170179578382;5830.3586605473365;5841.269841269841;5890.705464726747;5892.911606325909;5909.852253693606;5698.943010569841;5823.068309070529;5840.1239814027385;5917.053271476543;5919.467247947706;6555.475561955032;6570.868582628321;6587.63767992765;6643.10318107059;6643.269240383554;6788.49086318538;6794.830129246809;6811.489138314547;6868.313168683092;6887.242403335629;6400.199975003125;6528.543001989815;6546.901796472961;6620.801375958729;6644.800655980328;6648.468122550088;6722.361375669304;6762.594244345355;6767.627780472121;6770.221424536241;6694.866102677822;6802.591844489347;6830.965845170742;6878.7248510059035;6905.93094069073;6421.357864213542;6445.967770161306;6530.738770449128;6585.5719378240265;6657.034729964032;6606.174228221473;6665.400113989765;6681.064650948968;6685.331466853276;6697.899531507129;6339.683015849097;6430;6474.0612611172055;6512.511561632802;6613.074169616354;6508.316626754123;6538.803835884931;6552.3447655234095;6566.507511936719;6571.277159512354;6312.400321969406;6413.390727880844;6441.420272175526;6469.45009674183;6495.447886929664 03:18:17 INFO - PID 31775 | |1;ext.html;862.396322574198;885.8449771290022;889.0176355127584;890.9866352004719;893.2050475077178;37716.24567508648;38364.616353836456;38417;41680.79159604198;41849.7907510462;38391.808040959826;38434.23131537375;38462.8076859616;38598.4210236846;38807.61192388075;7000.789976300706;7103.325184107502;7115.78652640419;7116.181639111491;7700.4609677322605;7700.499467534621;7819.374450044012;7819.648115834772;7822.335101516378;7825.647845846951;7790.9610451947665;7831.177726338738;7847.372210223197;7849.25432083954;7854.567998760066;7799.5710235937;7830.412719046038;7830.530168189898;7840.960795195988;7842.725504607311;7726.266004729542;7743.806404839867;7764.029496312961;7789.337906277973;7796.4932279401655;37376.065598359986;37422;37452;37651.623483765085;37682.24635507275;3527.770694904823;3567.2152126532383;3568.2685049564775;3576.8032758198287;3581.4269716845442;31002.68997310043;31003.534946975815;31158.532622010687;31257.218569535715;31286;5106.514881086328;5138.997895410396;5168.896622067575;5174.2238664200295;5211.1922651989;185792;185963;186310;186478;186482;47554.52445475501;47641;47703.5229647706;47845.76077119662;47884.5211547887;44261.778691106985;45116;49906.50093499091;50578.49421505811;50595.74702126466;16075.517734467985;16351.345946162259;16371.09958952269;16398.508044758677;16409.753853691964;13324.800127998087;13335.799963000563;13353.132046416951;13466.528671496646;13491.055626106274;13859.653508662364;13898.861011389758;14042.227677477633;14115.082519636397;14188.219647919463;5605.775768969195;5630.746616402272;5753.194552762617;5759;5830.416958304136;981.5288661442547;994.2195376629311;1001.3841487485145;1008.5562352564848;1017.1811691588342;22256;22372.664410033864;22390.216342427935;22675.75283359431;22748.43128921757;1106.1980064453207;1107.9169062320198;1108.6009036746764;1114.3202646385698;1118.1837258800958;11974.341411222467;12014;12058.939705301418;12131.818022729665;12205.877941220651;219134;220586;220789;220807;220876;52341.7382913083;52529.212061819104;52537.211941820904;52732;52846;1409.1685905315912;1442.4446588063672;1447.5440236325524;1465.0403985389587;1476.328270636879;22165.88917055469;22468.32595022152;22469.662955056014;22547.43631409162;22605.208817691302;35969;36481.08797279983;36484.45273320849;36551.63448365482;36634.63365366312;184297;184695;184855;185964;186261;33670.32659346848;35438;36049.459258111674;36148.4577731329;36152.819235903655;45119.7744011291;46160.53839461562;46312;46316.30525542052;46463.53536464592;33857.322853543286;33956.32087358288;33977.66022339745;34335.828320858236;34503.4824477638;33216.66783332136;33575;33911;34515.13712157216;34576.654233457346;37249.627503724616;37529;37553.6244637561;37561.43657845189;37626.62373376341;32744.181395465304;33078.83460582778;33220.33559328751;33241.667583323855;33330.33339333248;24538.141165059136;24618.630720538848;24626.138085166935;24956.0017599294;25218 03:18:17 INFO - PID 31775 | |2;jquery.html;550.5815580159081;561.2731512691065;571.0520535910389;571.4628249445518;575.839683038677;21780.89109554452;22830.657540136912;22854.771452285473;22868.31395058147;22871.656925146137;23600.881995589996;24455.266342009767;24841.25476235716;25531.74468255317;25677.486450270982;6538.509611779112;6607.306232845554;6638.468922486214;6652.667366631673;6652.800415987504;6523.836904077389;6622.93377066228;6629.9668501657425;6632.933670663304;6638.502112341594;6375.521835862306;6575.901361479581;6589.04458853466;6649.468042556584;6656.833579160536;6631.237407698104;6658.4673226141795;6661.467082633378;6674.16572928384;6680.231773346079;6166.876662466726;6195.256569211679;6204.6587437690905;6206.844828879269;6219;28310.292242693893;29354.853225733947;29392.41215175706;29407.2648183795;29510.852445737848;2040.36748607932;2088.081244252524;2090.8640938339113;2091.1426315210692;2092.3095378525204;19056.71414928777;19595.90202048995;19738.60522789536;19832.603347933105;19886.70169947452;2422.6123820188686;2428.878556072207;2501.0371007162194;2508.6989561252585;2519.60946053362;120971.39514302372;126889;131815;138353.3082334592;138949.61050389468;14521.550019770577;14563.635909102146;14679.77980330296;14772.177951868962;14798.96407251482;23106.8844655779;23108.88445557795;23120.190793322152;23157.768422315563;23168.65247021296;10277.794444111225;10342.120919721758;10454.11140053104;10459.94770026145;10597.62908298206;9872.802543949081;9943.850842237372;9952.402855828674;9976.401415915068;10012.949935250277;8746.212840844228;8787.868181977276;8924.419912705653;8978.281737460988;9305.720828375159;2651.3371657085727;2678.2012796627573;2704.648395708545;2736.8094878727816;2773.639426874534;937.9390339627903;967.2929714683424;969.1634352901212;972.4797233480195;973.9220862331139;19268.518287042934;19359.612807744048;19561.804381956284;19608.21567137327;19884.105215265346;976.7216343342113;1008.470552959702;1012.3470361616863;1016.3241444439365;1021.7854250607455;10485.318454300446;10507.527161277761;10590.209483784452;10753.085987690978;10970.561177552969;441974;451378;452597;457760;461745;106381.46809265904;109836;110430;112302;112894;1002.0380434782545;1130.7851508213414;1156.809126494119;1165.4522374484147;1170.5727409495473;19880.50298742543;20466.38600841977;20489.180432782523;20499.590008199455;20597.52730167405;54682.45317546774;55520.167197492876;56310;56498;58400.70799645974;69841.30158698552;69977;70722.64638676774;71007;71140.64429677819;14153.08004979673;14257;14281.214533200773;14343.713125737218;14352.138871667734;22208.888955555118;22242;22310.330690079325;22856.428589285402;22941.426464338525;16999.83000170032;17767.822321776617;17892.373766918095;18223.362182323555;18368.90815545967;15874.444394446138;16062.59843503875;16513;16626.75059874127;16666.083365414535;17886.74792764494;18136.365227216986;18452.35416760407;18561.257549698403;18663.253469861596;14052.508162214273;14192.503262385768;14218.289085545475;14220.928895355457;14243.501477448239;18087.819121808614;18209.635807284045;18219.180136894138;18373.724394134366;18374.448766537025 03:18:17 INFO - PID 31775 | |3;mootools.html;1305.6801083734483;1381.9239941803203;1395.4209003263645;1402.495101763365;1404.2206575350676;14720.116792992429;15384.615384615376;15387.846121538782;15401.845981540182;15419.306131224093;14867.851321486782;15157.393704251845;15273.159976201305;15284;15284;2760.3789147441867;2780.8470534120665;2827.915162545127;2832.957505637417;2840.162152165106;2680.1825443239804;2770.515159847029;2783.7633801126926;2790.372166262595;2794.9860250698716;2308.0998410619873;2404.362843846382;2406.987965060181;2762.599423083652;2797.146870204587;2776.1671498550454;2826.9293267668268;2852.9001484948135;2855.8286502809897;2858.4997625415467;2606.609008648699;2630.7500787425165;2649.1125472966387;2663.853488058156;2677.143314139476;14668.779968300483;14803.0378025428;14867.256637168206;14877.18175500347;14897.404103835834;7953.323967462773;8198.42611017229;8199.098099209083;8267.958660206721;8272.33821294295;5271.288376069258;5579.832605021856;5780.9710951445395;5781.4507621775865;5812.738426770806;1911.2355057976781;1913.6746753052014;1918.0889077687987;1983.8456853602697;1995.4213278149318;26366.73633263681;26480.73519264821;26550.6017409739;26625.866870665715;26672.733272667218;7189.317014883578;7214.891776623354;7277.417806575567;7467.701291948261;7505.211952744992;19522.219111235674;19668.606627867364;19688.114034868464;19703.211871525265;19703.310384136486;8219.178082191853;8234.382421318305;8249.257566818895;8252.21603947624;8257.793555161048;7036.050133231948;7403.85192296151;7491.513051651626;7503.474756767083;7514.47398682087;5417.241586177938;5691.630044047124;5739.282589676291;5741.96644603967;5777.971110144423;1567.968640627181;1603.6311648320718;1615.200475764504;1747.8689098317677;1841.1530695879778;884.6638277454655;898.5686870302292;907.265115256631;907.5862480304882;913.9223166030829;8725.389222754473;8735.694250701195;8742;8776.956115219384;8842.115788421235;977.5796407544682;982.1504398695077;993.3841018568389;993.7068564773265;1002.1460298447813;5287.576993840484;5321.441248668912;5403.918941215885;5437.293151890308;5478.780848766084;21311.25410610621;22685.319440416813;22685.546289074126;22714.318570442912;22772.31683049511;20843.478913027295;21821.890890545445;22046;22065.669014964787;22385.888070559544;10331.690049298382;10373.896261037444;10429.68710938673;10464.686059418229;10481.685549433529;7978.0825205102155;8608.311335093304;8616.439931404439;8768.167024132697;8773.956130219309;18222.908885455487;18828.905855471185;18913.148908298885;18914.905425473335;19289.421317360502;19338.22647094157;19338.613227735084;19613.901930490258;19932.20271189136;19972.20111195594;10890.455477226265;10903.563857445613;10998.285111467729;11009.229353945468;11012.834807478055;13811.240381779098;13935.721285574435;14085.859141408455;14090.084144530572;14093.647658808612;11182;11311.71720706956;11368.886311137114;11589.942050289694;11704.590339338083;11096;11261.774764504828;11339.206255562032;11385.203035787416;11449.771004579696;10022.098011179029;10109.64616238428;10246.795064098826;10252.282340236112;10259.435731034864;7405.629718513945;7413.703451861865;7414.073240844895;7482.812929676584;7525.096988361432;7163.7492687755675;7237.095363079615;7270.9636451817405;7314.634268286671;7322.450816188701 03:18:17 INFO - PID 31775 | |4;prototype.html;498.7581023203746;512.088482501148;529.7457220534144;531.7102179312275;540.0468173673466;6280.4661603763625;6333.429991300782;6338.587991780537;6346.968265158668;6399.328070552595;6261.843453913654;6271.184745983027;6281.43467087962;6297.118403423513;6327.330148513863;5193.195054766507;5210.348706411699;5213.687178769286;5245.606579506533;5258.421573626898;5057.013882292954;5151.201563757623;5233.4243233244315;5261.552768014723;5274.709890955995;4772.80908763649;4908.631852611051;4952.851414457572;4963.305137280783;4981.975090124544;4938.629602779788;4939.209726443788;4943.6539442239055;4979.278004689336;4982.87542811429;4319.330503771889;4414.205443020255;4426.424564806554;4426.535213802569;4430.800613972379;6018.909716354258;6058.485028772516;6128.7242074106325;6134.325224225332;6165.876682466371;5688.009196781093;5688.232088668018;5691.886162276731;5698.715064246771;5712.428757124254;6444.194475690539;6540.607563546155;6562.114114594517;6567.244766851825;6570.408663220285;4651.162790697673;4885.728136416547;4888.193448081062;4909.754512274372;4912.115819152551;6680.799576012728;6773.627450490221;6837.837567613517;6879.140107486614;6883.931160688379;4980.327655766425;4996.050750357421;5002.52476014778;5005.6996580205305;5038.168702164176;5011.57401620859;5029.346184995927;5047.747612619354;5050.797968081309;5083.949160508421;5571.9442805572235;5645.717714114277;5652.0674088774895;5665.461781130786;5665.5467562594895;6558.704858281389;6601.095517972077;6603.900941485882;6627.138471998609;6642.368974947372;1749.4314347837003;1750.2036573359092;1751.3957684598793;1764.7823002128746;1767.8674099442594;1138.5218208352512;1182.5742732616252;1200.153891506486;1217.598192596441;1222.10175520992;5600.85997850057;5627.493525582717;5659.801906933238;5668.206451096849;5719.026935707175;6537.640429776313;6636.63948890486;6684.86630267392;6722.865542689216;6765.8646827063185;5593.328800543961;5625.324961004706;5644.491995720405;5652.547796176296;5699.090804580512;3442;3554.751167418256;3564.946525802115;3575.1598374382;3589.1565482111682;6299.212598425197;6349.301546842574;6452.35476452351;6461.61230326182;6485.4163125318;6744.494162937701;6809.897851532231;6814.046033555306;6830.146231721035;6847.6446541194455;6383.755167742339;6405.967970160213;6462.256840463407;6486.156799616019;6496.415322620986;6240.1903448001385;6484.383983521558;6611.537192396486;6623.437007854193;6639.937609982379;6405.647689376942;6461.773837915838;6529.836754081186;6543.312952139957;6581.868362632817;6249.656268905072;6258.436740693177;6344.651044192429;6368.9044664330995;6383.489320854414;4908.263760435821;4914.36113305268;4926.162552366035;4935.75321233944;4951.925721114114;6406.423421892052;6497.913491091883;6519.4132528072705;6655.633940133339;6692.230393504809;6243.37566243372;6483.254425740912;6500.772472963424;6508.704255191551;6512.479001679949;6480.57876238043;6495.935040649533;6512.120863683342;6526.934730652632;6529.118568993125;6321.494280457644;6416.197975253093;6425.839354016187;6428.389303016206;6434.324395938359;6536.346365363425;6561.507886908596;6587.341265873374;6589.703463344257;6597.0764093026055;6387.169667943138;6391.968040159955;6413.35866413355;6429.678516074271;6452.612843229421 03:18:17 INFO - PID 31775 | |5;yui.html;882.3162049411706;882.858742601184;907.2560500389679;921.1479381572049;923.247553244106;16910.915445422772;17663.381781637647;17692.557686057855;17702.822971770278;17760.289588416465;16001.119938403383;16008.919955400206;16220.918895405506;16281.511554653349;17215.655686886254;964.9903500965006;974.6442548469828;979.2606582030556;979.4661909259471;979.5004547680699;975.7560609847538;981.4062492192228;983.8179936711696;986.3884391677134;986.866772985645;998.9300748947541;1024.3751311699857;1031.3554028732042;1042.525650828871;1046.2780681329857;1007.9798404031951;1014.9035841595111;1017.3793985668736;1017.7557386227326;1018.1854516386861;710.5914099392818;739.0429393934867;741.4365082537256;745.7352639812842;749.5015814483362;17828.643427131385;18021.549461263443;18035;18039;18059.187336569754;18365.7245141323;18514;18585.535361615934;19090.904545477184;19095.331663391855;17119.91440042792;17499;17583.824161758475;17612;17823.643527129385;3757;3778.886633401002;3781.3004594149897;3783.5459744830523;3784.2242340320167;138418;138907.99999999898;138915;142739.28630356886;142849.2857535716;16574.6685066298;16698.248578813982;16802.747958780627;16859.578510537336;16935.32258709638;31073;31506;31531.36937261242;31553.211169720482;31631.367372652418;8829.470231786114;8830.116988301246;8843.425177363579;8917.019127895926;8920.063393343735;4193.559676234013;4286.957130428718;4294.377315289265;4307.224699554048;4312.54718254585;5348.732563371816;5464.153056276284;5483.396826349099;5500.614956952975;5522.199281104217;971.8736564246602;996.8355221388534;1006.5420233793607;1009.6163457885956;1016.9593216271414;694.5728377048079;702.7610612391709;705.989410158848;709.8438343564408;715.9069320988239;10922.890771092347;11298.322100673822;11339.886601133883;11984.64046078619;12186.146969712036;682.8804959132132;686.9072675188786;701.8034950213948;704.3871831506622;704.63359053292;5446.673199608036;5452.345718513804;5539.41836107211;5639.2668953035845;5642.322921249476;114139;115784.42107789408;117845;119886;120028;104896.95103049025;105831;106905;108015;108684;94630.52684736533;95443.52278238564;96169;98590.5070474643;99776;10242.334248273839;10382.532786024496;10448.843267351147;10475.423851687925;10553.630622928467;43332.566674332855;44569;44772.32841507445;45370.77314613406;45981.540184597725;56316.7184164093;56535.43464565466;56864;57218.42781572298;58759.70620146872;15180.696386072437;15597.844021559638;15653.139077350856;15702.607434814221;15861.444849430676;16499;16713.749293760848;16746.916265418597;16781.832181678514;17021;16531.173441327646;16539.66920661604;16540.917295413445;16650.084245366623;16731.163441828103;15955;16333.673326533166;16431;16431.589210269838;16503.504894853173;14880.255987200813;14935.775963360342;14978.1013139212;15102.848971510144;15172.696546069237;11336.376499292619;11611.941940290244;11640.417979101181;11749.353785541878;11998.700032499257;10067.1442927352;10254.92323306042;10317.638882639072;10410.375377477376;10498.790024199321 03:18:17 INFO - PID 31775 | __end_tp_report 03:18:17 INFO - PID 31775 | __start_cc_report 03:18:17 INFO - PID 31775 | _x_x_mozilla_cycle_collect,368 03:18:17 INFO - PID 31775 | __end_cc_report 03:18:17 INFO - PID 31775 | __startTimestamp1505470697736__endTimestamp 03:18:17 INFO - PID 31775 | 03:18:17 INFO - PID 31775 | ------- Summary: start ------- 03:18:17 INFO - PID 31775 | Number of tests: 6 03:18:17 INFO - PID 31775 | 03:18:17 INFO - PID 31775 | [#0] dojo.html Cycles:165 Average:6224.29 Median:6445.97 stddev:759.52 (11.8%) stddev-sans-first:722.58 03:18:17 INFO - PID 31775 | Values: 3151.3 3156.1 3169.8 3183.0 3227.5 6142.9 6270.0 6350.2 6365.4 6438.5 6261.6 6295.1 6411.7 6428.6 6438.8 5711.6 5796.8 5846.2 5846.4 5905.2 5780.2 5800.9 5848.3 5861.9 5885.9 5592.7 5693.8 5714.7 5754.0 5779.4 5659.7 5762.5 5763.5 5783.9 5813.0 5663.9 5753.7 5773.9 5788.7 5838.5 6183.9 6246.7 6251.2 6354.9 6382.4 6654.5 6724.2 6741.4 6788.3 6789.6 6754.8 6827.6 6850.3 6858.8 6868.1 6106.6 6129.2 6157.0 6359.9 6376.2 7031.8 7067.9 7073.6 7075.2 7081.2 6641.3 6645.1 6671.3 6742.5 6751.3 6484.0 6573.5 6734.2 6805.9 6812.2 6764.9 6768.1 6775.8 6778.4 6781.6 6797.1 6832.7 6856.3 6863.6 6873.0 5303.0 5319.7 5363.4 5381.7 5383.5 4485.0 4569.6 4579.9 4589.9 4667.6 5819.9 5833.3 5838.9 5867.4 5890.3 6736.7 6821.6 6887.2 6900.6 6915.2 5830.4 5841.3 5890.7 5892.9 5909.9 5698.9 5823.1 5840.1 5917.1 5919.5 6555.5 6570.9 6587.6 6643.1 6643.3 6788.5 6794.8 6811.5 6868.3 6887.2 6400.2 6528.5 6546.9 6620.8 6644.8 6648.5 6722.4 6762.6 6767.6 6770.2 6694.9 6802.6 6831.0 6878.7 6905.9 6421.4 6446.0 6530.7 6585.6 6657.0 6606.2 6665.4 6681.1 6685.3 6697.9 6339.7 6430.0 6474.1 6512.5 6613.1 6508.3 6538.8 6552.3 6566.5 6571.3 6312.4 6413.4 6441.4 6469.5 6495.4 03:18:17 INFO - PID 31775 | 03:18:17 INFO - PID 31775 | [#1] ext.html Cycles:180 Average:36851.09 Median:36009.23 stddev:51187.06 (142.1%) stddev-sans-first:51259.32 03:18:17 INFO - PID 31775 | Values: 862.4 885.8 889.0 891.0 893.2 37716.2 38364.6 38417.0 41680.8 41849.8 38391.8 38434.2 38462.8 38598.4 38807.6 7000.8 7103.3 7115.8 7116.2 7700.5 7700.5 7819.4 7819.6 7822.3 7825.6 7791.0 7831.2 7847.4 7849.3 7854.6 7799.6 7830.4 7830.5 7841.0 7842.7 7726.3 7743.8 7764.0 7789.3 7796.5 37376.1 37422.0 37452.0 37651.6 37682.2 3527.8 3567.2 3568.3 3576.8 3581.4 31002.7 31003.5 31158.5 31257.2 31286.0 5106.5 5139.0 5168.9 5174.2 5211.2 185792.0 185963.0 186310.0 186478.0 186482.0 47554.5 47641.0 47703.5 47845.8 47884.5 44261.8 45116.0 49906.5 50578.5 50595.7 16075.5 16351.3 16371.1 16398.5 16409.8 13324.8 13335.8 13353.1 13466.5 13491.1 13859.7 13898.9 14042.2 14115.1 14188.2 5605.8 5630.7 5753.2 5759.0 5830.4 981.5 994.2 1001.4 1008.6 1017.2 22256.0 22372.7 22390.2 22675.8 22748.4 1106.2 1107.9 1108.6 1114.3 1118.2 11974.3 12014.0 12058.9 12131.8 12205.9 219134.0 220586.0 220789.0 220807.0 220876.0 52341.7 52529.2 52537.2 52732.0 52846.0 1409.2 1442.4 1447.5 1465.0 1476.3 22165.9 22468.3 22469.7 22547.4 22605.2 35969.0 36481.1 36484.5 36551.6 36634.6 184297.0 184695.0 184855.0 185964.0 186261.0 33670.3 35438.0 36049.5 36148.5 36152.8 45119.8 46160.5 46312.0 46316.3 46463.5 33857.3 33956.3 33977.7 34335.8 34503.5 33216.7 33575.0 33911.0 34515.1 34576.7 37249.6 37529.0 37553.6 37561.4 37626.6 32744.2 33078.8 33220.3 33241.7 33330.3 24538.1 24618.6 24626.1 24956.0 25218.0 03:18:17 INFO - PID 31775 | 03:18:17 INFO - PID 31775 | [#2] jquery.html Cycles:180 Average:33361.59 Median:22855.60 stddev:76521.89 (334.8%) stddev-sans-first:76696.90 03:18:17 INFO - PID 31775 | Values: 550.6 561.3 571.1 571.5 575.8 21780.9 22830.7 22854.8 22868.3 22871.7 23600.9 24455.3 24841.3 25531.7 25677.5 6538.5 6607.3 6638.5 6652.7 6652.8 6523.8 6622.9 6630.0 6632.9 6638.5 6375.5 6575.9 6589.0 6649.5 6656.8 6631.2 6658.5 6661.5 6674.2 6680.2 6166.9 6195.3 6204.7 6206.8 6219.0 28310.3 29354.9 29392.4 29407.3 29510.9 2040.4 2088.1 2090.9 2091.1 2092.3 19056.7 19595.9 19738.6 19832.6 19886.7 2422.6 2428.9 2501.0 2508.7 2519.6 120971.4 126889.0 131815.0 138353.3 138949.6 14521.6 14563.6 14679.8 14772.2 14799.0 23106.9 23108.9 23120.2 23157.8 23168.7 10277.8 10342.1 10454.1 10459.9 10597.6 9872.8 9943.9 9952.4 9976.4 10012.9 8746.2 8787.9 8924.4 8978.3 9305.7 2651.3 2678.2 2704.6 2736.8 2773.6 937.9 967.3 969.2 972.5 973.9 19268.5 19359.6 19561.8 19608.2 19884.1 976.7 1008.5 1012.3 1016.3 1021.8 10485.3 10507.5 10590.2 10753.1 10970.6 441974.0 451378.0 452597.0 457760.0 461745.0 106381.5 109836.0 110430.0 112302.0 112894.0 1002.0 1130.8 1156.8 1165.5 1170.6 19880.5 20466.4 20489.2 20499.6 20597.5 54682.5 55520.2 56310.0 56498.0 58400.7 69841.3 69977.0 70722.6 71007.0 71140.6 14153.1 14257.0 14281.2 14343.7 14352.1 22208.9 22242.0 22310.3 22856.4 22941.4 16999.8 17767.8 17892.4 18223.4 18368.9 15874.4 16062.6 16513.0 16626.8 16666.1 17886.7 18136.4 18452.4 18561.3 18663.3 14052.5 14192.5 14218.3 14220.9 14243.5 18087.8 18209.6 18219.2 18373.7 18374.4 03:18:17 INFO - PID 31775 | 03:18:17 INFO - PID 31775 | [#3] mootools.html Cycles:180 Average:9523.34 Median:14498.74 stddev:6806.92 (46.9%) stddev-sans-first:6798.01 03:18:17 INFO - PID 31775 | Values: 1305.7 1381.9 1395.4 1402.5 1404.2 14720.1 15384.6 15387.8 15401.8 15419.3 14867.9 15157.4 15273.2 15284.0 15284.0 2760.4 2780.8 2827.9 2833.0 2840.2 2680.2 2770.5 2783.8 2790.4 2795.0 2308.1 2404.4 2407.0 2762.6 2797.1 2776.2 2826.9 2852.9 2855.8 2858.5 2606.6 2630.8 2649.1 2663.9 2677.1 14668.8 14803.0 14867.3 14877.2 14897.4 7953.3 8198.4 8199.1 8268.0 8272.3 5271.3 5579.8 5781.0 5781.5 5812.7 1911.2 1913.7 1918.1 1983.8 1995.4 26366.7 26480.7 26550.6 26625.9 26672.7 7189.3 7214.9 7277.4 7467.7 7505.2 19522.2 19668.6 19688.1 19703.2 19703.3 8219.2 8234.4 8249.3 8252.2 8257.8 7036.1 7403.9 7491.5 7503.5 7514.5 5417.2 5691.6 5739.3 5742.0 5778.0 1568.0 1603.6 1615.2 1747.9 1841.2 884.7 898.6 907.3 907.6 913.9 8725.4 8735.7 8742.0 8777.0 8842.1 977.6 982.2 993.4 993.7 1002.1 5287.6 5321.4 5403.9 5437.3 5478.8 21311.3 22685.3 22685.5 22714.3 22772.3 20843.5 21821.9 22046.0 22065.7 22385.9 10331.7 10373.9 10429.7 10464.7 10481.7 7978.1 8608.3 8616.4 8768.2 8774.0 18222.9 18828.9 18913.1 18914.9 19289.4 19338.2 19338.6 19613.9 19932.2 19972.2 10890.5 10903.6 10998.3 11009.2 11012.8 13811.2 13935.7 14085.9 14090.1 14093.6 11182.0 11311.7 11368.9 11589.9 11704.6 11096.0 11261.8 11339.2 11385.2 11449.8 10022.1 10109.6 10246.8 10252.3 10259.4 7405.6 7413.7 7414.1 7482.8 7525.1 7163.7 7237.1 7271.0 7314.6 7322.5 03:18:17 INFO - PID 31775 | 03:18:17 INFO - PID 31775 | [#4] prototype.html Cycles:180 Average:5484.56 Median:6241.78 stddev:1528.75 (24.5%) stddev-sans-first:1486.53 03:18:17 INFO - PID 31775 | Values: 498.8 512.1 529.7 531.7 540.0 6280.5 6333.4 6338.6 6347.0 6399.3 6261.8 6271.2 6281.4 6297.1 6327.3 5193.2 5210.3 5213.7 5245.6 5258.4 5057.0 5151.2 5233.4 5261.6 5274.7 4772.8 4908.6 4952.9 4963.3 4982.0 4938.6 4939.2 4943.7 4979.3 4982.9 4319.3 4414.2 4426.4 4426.5 4430.8 6018.9 6058.5 6128.7 6134.3 6165.9 5688.0 5688.2 5691.9 5698.7 5712.4 6444.2 6540.6 6562.1 6567.2 6570.4 4651.2 4885.7 4888.2 4909.8 4912.1 6680.8 6773.6 6837.8 6879.1 6883.9 4980.3 4996.1 5002.5 5005.7 5038.2 5011.6 5029.3 5047.7 5050.8 5083.9 5571.9 5645.7 5652.1 5665.5 5665.5 6558.7 6601.1 6603.9 6627.1 6642.4 1749.4 1750.2 1751.4 1764.8 1767.9 1138.5 1182.6 1200.2 1217.6 1222.1 5600.9 5627.5 5659.8 5668.2 5719.0 6537.6 6636.6 6684.9 6722.9 6765.9 5593.3 5625.3 5644.5 5652.5 5699.1 3442.0 3554.8 3564.9 3575.2 3589.2 6299.2 6349.3 6452.4 6461.6 6485.4 6744.5 6809.9 6814.0 6830.1 6847.6 6383.8 6406.0 6462.3 6486.2 6496.4 6240.2 6484.4 6611.5 6623.4 6639.9 6405.6 6461.8 6529.8 6543.3 6581.9 6249.7 6258.4 6344.7 6368.9 6383.5 4908.3 4914.4 4926.2 4935.8 4951.9 6406.4 6497.9 6519.4 6655.6 6692.2 6243.4 6483.3 6500.8 6508.7 6512.5 6480.6 6495.9 6512.1 6526.9 6529.1 6321.5 6416.2 6425.8 6428.4 6434.3 6536.3 6561.5 6587.3 6589.7 6597.1 6387.2 6392.0 6413.4 6429.7 6452.6 03:18:17 INFO - PID 31775 | 03:18:17 INFO - PID 31775 | [#5] yui.html Cycles:180 Average:23895.29 Median:17791.97 stddev:34997.66 (196.7%) stddev-sans-first:35053.18 03:18:17 INFO - PID 31775 | Values: 882.3 882.9 907.3 921.1 923.2 16910.9 17663.4 17692.6 17702.8 17760.3 16001.1 16008.9 16220.9 16281.5 17215.7 965.0 974.6 979.3 979.5 979.5 975.8 981.4 983.8 986.4 986.9 998.9 1024.4 1031.4 1042.5 1046.3 1008.0 1014.9 1017.4 1017.8 1018.2 710.6 739.0 741.4 745.7 749.5 17828.6 18021.5 18035.0 18039.0 18059.2 18365.7 18514.0 18585.5 19090.9 19095.3 17119.9 17499.0 17583.8 17612.0 17823.6 3757.0 3778.9 3781.3 3783.5 3784.2 138418.0 138908.0 138915.0 142739.3 142849.3 16574.7 16698.2 16802.7 16859.6 16935.3 31073.0 31506.0 31531.4 31553.2 31631.4 8829.5 8830.1 8843.4 8917.0 8920.1 4193.6 4287.0 4294.4 4307.2 4312.5 5348.7 5464.2 5483.4 5500.6 5522.2 971.9 996.8 1006.5 1009.6 1017.0 694.6 702.8 706.0 709.8 715.9 10922.9 11298.3 11339.9 11984.6 12186.1 682.9 686.9 701.8 704.4 704.6 5446.7 5452.3 5539.4 5639.3 5642.3 114139.0 115784.4 117845.0 119886.0 120028.0 104897.0 105831.0 106905.0 108015.0 108684.0 94630.5 95443.5 96169.0 98590.5 99776.0 10242.3 10382.5 10448.8 10475.4 10553.6 43332.6 44569.0 44772.3 45370.8 45981.5 56316.7 56535.4 56864.0 57218.4 58759.7 15180.7 15597.8 15653.1 15702.6 15861.4 16499.0 16713.7 16746.9 16781.8 17021.0 16531.2 16539.7 16540.9 16650.1 16731.2 15955.0 16333.7 16431.0 16431.6 16503.5 14880.3 14935.8 14978.1 15102.8 15172.7 11336.4 11611.9 11640.4 11749.4 11998.7 10067.1 10254.9 10317.6 10410.4 10498.8 03:18:17 INFO - PID 31775 | -------- Summary: end -------- 03:18:17 INFO - PID 31775 | 03:18:18 INFO - TEST-INFO | 31775: exit 0 03:18:18 INFO - TEST-OK | dromaeo_css | took 1110403ms 03:18:18 INFO - TEST-START | kraken 03:18:18 INFO - Initialising browser for kraken test... 03:18:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39279/getInfo.html -profile /tmp/tmp7O4m7U/profile 03:18:18 INFO - TEST-INFO | started process 32165 (/builds/slave/test/build/application/firefox/firefox http://localhost:39279/getInfo.html) 03:18:24 INFO - TEST-INFO | 32165: exit 0 03:18:24 INFO - Browser initialized. 03:18:24 INFO - Running cycle 1/1 for kraken test... 03:18:24 INFO - Using env: {'DISPLAY': ':0', 03:18:24 INFO - 'HOME': '/home/cltbld', 03:18:24 INFO - 'JSGC_DISABLE_POISONING': '1', 03:18:24 INFO - 'LANG': 'en_US.UTF-8', 03:18:24 INFO - 'LANGUAGE': 'en_US:en', 03:18:24 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:18:24 INFO - 'LOGNAME': 'cltbld', 03:18:24 INFO - 'MAIL': '/var/mail/cltbld', 03:18:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:18:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:18:24 INFO - 'MOZ_CRASHREPORTER': '1', 03:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:24 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:18:24 INFO - 'MOZ_NO_REMOTE': '1', 03:18:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:24 INFO - 'NO_EM_RESTART': '1', 03:18:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:24 INFO - 'PWD': '/builds/slave/test', 03:18:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:18:24 INFO - 'RUST_BACKTRACE': 'full', 03:18:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:18:24 INFO - 'SHELL': '/bin/bash', 03:18:24 INFO - 'SHLVL': '1', 03:18:24 INFO - 'TERM': 'linux', 03:18:24 INFO - 'TMOUT': '86400', 03:18:24 INFO - 'USER': 'cltbld', 03:18:24 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433', 03:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:24 INFO - '_': '/tools/buildbot/bin/python'} 03:18:24 INFO - TEST-INFO | started process 32403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7O4m7U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:25 INFO - PID 32403 | 03:18:25 INFO - PID 32403 | (/builds/slave/test/build/application/firefox/firefox:32453): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:18:25 INFO - PID 32403 | 03:18:35 INFO - PID 32403 | RSS: Main: 171393024 03:18:35 INFO - PID 32403 | 03:18:38 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39279/tests/kraken/driver.html?testName=audio-beat-detection) 03:18:39 INFO - PID 32403 | RSS: Main: 176398336 03:18:39 INFO - PID 32403 | 03:18:42 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39279/tests/kraken/driver.html?testName=audio-dft) 03:18:42 INFO - PID 32403 | RSS: Main: 176971776 03:18:42 INFO - PID 32403 | 03:18:45 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39279/tests/kraken/driver.html?testName=audio-fft) 03:18:46 INFO - PID 32403 | RSS: Main: 172503040 03:18:46 INFO - PID 32403 | 03:18:48 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39279/tests/kraken/driver.html?testName=audio-oscillator) 03:18:49 INFO - PID 32403 | RSS: Main: 172748800 03:18:49 INFO - PID 32403 | 03:18:51 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:18:51 INFO - PID 32403 | RSS: Main: 172957696 03:18:51 INFO - PID 32403 | 03:18:55 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39279/tests/kraken/driver.html?testName=imaging-darkroom) 03:18:55 INFO - PID 32403 | RSS: Main: 175603712 03:18:55 INFO - PID 32403 | 03:18:59 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39279/tests/kraken/driver.html?testName=imaging-desaturate) 03:18:59 INFO - PID 32403 | RSS: Main: 175779840 03:18:59 INFO - PID 32403 | 03:19:02 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39279/tests/kraken/driver.html?testName=json-parse-financial) 03:19:03 INFO - PID 32403 | RSS: Main: 176697344 03:19:03 INFO - PID 32403 | 03:19:05 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:19:05 INFO - PID 32403 | RSS: Main: 176070656 03:19:05 INFO - PID 32403 | 03:19:07 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39279/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:19:08 INFO - PID 32403 | RSS: Main: 172773376 03:19:08 INFO - PID 32403 | 03:19:10 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:19:10 INFO - PID 32403 | RSS: Main: 173305856 03:19:10 INFO - PID 32403 | 03:19:13 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:19:14 INFO - PID 32403 | RSS: Main: 173572096 03:19:14 INFO - PID 32403 | 03:19:17 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:19:17 INFO - PID 32403 | RSS: Main: 173502464 03:19:17 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | Cycle 1(1): loaded http://localhost:39279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39279/tests/kraken/driver.html?testName=ai-astar) 03:19:19 INFO - PID 32403 | RSS: Main: 175071232 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | __start_tp_report 03:19:19 INFO - PID 32403 | _x_x_mozilla_page_load 03:19:19 INFO - PID 32403 | _x_x_mozilla_page_load_details 03:19:19 INFO - PID 32403 | |i|pagename|runs| 03:19:19 INFO - PID 32403 | |0;ai-astar;109;109;109;109;107;108;110;108;108;108 03:19:19 INFO - PID 32403 | |1;audio-beat-detection;118;116;116;119;118;115;117;116;115;119 03:19:19 INFO - PID 32403 | |2;audio-dft;163;163;167;164;163;162;167;167;163;169 03:19:19 INFO - PID 32403 | |3;audio-fft;74;77;72;73;73;74;72;76;75;75 03:19:19 INFO - PID 32403 | |4;audio-oscillator;79;79;80;80;80;81;79;79;79;79 03:19:19 INFO - PID 32403 | |5;imaging-gaussian-blur;114;115;114;114;113;113;113;115;114;113 03:19:19 INFO - PID 32403 | |6;imaging-darkroom;149;148;149;149;148;148;148;150;148;149 03:19:19 INFO - PID 32403 | |7;imaging-desaturate;94;93;94;94;94;94;94;95;94;96 03:19:19 INFO - PID 32403 | |8;json-parse-financial;54;53;54;54;55;60;52;52;52;51 03:19:19 INFO - PID 32403 | |9;json-stringify-tinderbox;38;38;37;38;38;38;38;39;38;38 03:19:19 INFO - PID 32403 | |10;stanford-crypto-aes;77;76;78;75;80;74;76;75;76;74 03:19:19 INFO - PID 32403 | |11;stanford-crypto-ccm;115;126;113;111;115;119;111;110;117;111 03:19:19 INFO - PID 32403 | |12;stanford-crypto-pbkdf2;172;174;169;166;166;170;174;177;176;187 03:19:19 INFO - PID 32403 | |13;stanford-crypto-sha256-iterative;71;68;67;67;66;68;68;67;65;71 03:19:19 INFO - PID 32403 | __end_tp_report 03:19:19 INFO - PID 32403 | __start_cc_report 03:19:19 INFO - PID 32403 | _x_x_mozilla_cycle_collect,965 03:19:19 INFO - PID 32403 | __end_cc_report 03:19:19 INFO - PID 32403 | __startTimestamp1505470759873__endTimestamp 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | ------- Summary: start ------- 03:19:19 INFO - PID 32403 | Number of tests: 14 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#0] ai-astar Cycles:10 Average:108.50 Median:109.00 stddev:0.85 (0.8%) stddev-sans-first:0.88 03:19:19 INFO - PID 32403 | Values: 109.0 109.0 109.0 109.0 107.0 108.0 110.0 108.0 108.0 108.0 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#1] audio-beat-detection Cycles:10 Average:116.90 Median:117.50 stddev:1.52 (1.3%) stddev-sans-first:1.56 03:19:19 INFO - PID 32403 | Values: 118.0 116.0 116.0 119.0 118.0 115.0 117.0 116.0 115.0 119.0 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.50 stddev:2.44 (1.5%) stddev-sans-first:2.50 03:19:19 INFO - PID 32403 | Values: 163.0 163.0 167.0 164.0 163.0 162.0 167.0 167.0 163.0 169.0 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#3] audio-fft Cycles:10 Average:74.10 Median:74.50 stddev:1.66 (2.2%) stddev-sans-first:1.76 03:19:19 INFO - PID 32403 | Values: 74.0 77.0 72.0 73.0 73.0 74.0 72.0 76.0 75.0 75.0 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:79.50 stddev:0.71 (0.9%) stddev-sans-first:0.73 03:19:19 INFO - PID 32403 | Values: 79.0 79.0 80.0 80.0 80.0 81.0 79.0 79.0 79.0 79.0 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 03:19:19 INFO - PID 32403 | Values: 114.0 115.0 114.0 114.0 113.0 113.0 113.0 115.0 114.0 113.0 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 03:19:19 INFO - PID 32403 | Values: 149.0 148.0 149.0 149.0 148.0 148.0 148.0 150.0 148.0 149.0 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 03:19:19 INFO - PID 32403 | Values: 94.0 93.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 96.0 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:2.54 (4.7%) stddev-sans-first:2.69 03:19:19 INFO - PID 32403 | Values: 54.0 53.0 54.0 54.0 55.0 60.0 52.0 52.0 52.0 51.0 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.47 (1.2%) stddev-sans-first:0.50 03:19:19 INFO - PID 32403 | Values: 38.0 38.0 37.0 38.0 38.0 38.0 38.0 39.0 38.0 38.0 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.00 stddev:1.85 (2.4%) stddev-sans-first:1.94 03:19:19 INFO - PID 32403 | Values: 77.0 76.0 78.0 75.0 80.0 74.0 76.0 75.0 76.0 74.0 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#11] stanford-crypto-ccm Cycles:10 Average:114.80 Median:115.00 stddev:4.92 (4.3%) stddev-sans-first:5.21 03:19:19 INFO - PID 32403 | Values: 115.0 126.0 113.0 111.0 115.0 119.0 111.0 110.0 117.0 111.0 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:174.00 stddev:6.21 (3.6%) stddev-sans-first:6.57 03:19:19 INFO - PID 32403 | Values: 172.0 174.0 169.0 166.0 166.0 170.0 174.0 177.0 176.0 187.0 03:19:19 INFO - PID 32403 | 03:19:19 INFO - PID 32403 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.93 (2.8%) stddev-sans-first:1.67 03:19:19 INFO - PID 32403 | Values: 71.0 68.0 67.0 67.0 66.0 68.0 68.0 67.0 65.0 71.0 03:19:19 INFO - PID 32403 | -------- Summary: end -------- 03:19:19 INFO - PID 32403 | 03:19:20 INFO - PID 32403 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:19:20 INFO - TEST-INFO | 32403: exit 0 03:19:20 INFO - TEST-OK | kraken | took 62207ms 03:19:20 INFO - SUITE-END | took 1172s 03:19:21 INFO - Completed test suite (00:19:33) 03:19:21 INFO - javascript benchmark 03:19:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8503.49716512074, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3151.259454028303, 3156.100511354263, 3169.7622678299126, 3183.029176101288, 3227.467467867802, 6142.938570614292, 6270.0, 6350.174477317948, 6365.363463653638, 6438.549301548894, 6261.561690681654, 6295.118683384329, 6411.711472983715, 6428.646424446653, 6438.774642887488, 5711.600187986843, 5796.768129274824, 5846.2107615472005, 5846.415358464141, 5905.232319798421, 5780.1907732917425, 5800.941990580082, 5848.298204215479, 5861.912071318934, 5885.8822823543505, 5592.692401917893, 5693.829185124411, 5714.742836572344, 5754.0, 5779.393163717791, 5659.717014149276, 5762.481376676077, 5763.510101641324, 5783.913241301384, 5813.0, 5663.886722265532, 5753.741081651336, 5773.88452230953, 5788.739506722208, 5838.5329173666005, 6183.907241391383, 6246.687665616746, 6251.249850018027, 6354.904676429857, 6382.393672601142, 6654.534182607219, 6724.159480064992, 6741.359570840762, 6788.287229840845, 6789.592624442549, 6754.8311292217595, 6827.5562088464585, 6850.349216824394, 6858.794236172923, 6868.072810170613, 6106.633601983851, 6129.233845769279, 6156.969215153896, 6359.904601430982, 6376.171097757308, 7031.7890463286185, 7067.89398159028, 7073.646317684095, 7075.2217256101785, 7081.150261968597, 6641.335866413417, 6645.06969024337, 6671.33286671329, 6742.49431292655, 6751.25736169021, 6483.994980777987, 6573.539852210395, 6734.191896972395, 6805.93194068053, 6812.216595091529, 6764.932350676529, 6768.120144381199, 6775.796726098225, 6778.389944904982, 6781.6270105144695, 6797.116374871334, 6832.6925288362145, 6856.280090590416, 6863.622500762506, 6872.965635171792, 5303.0, 5319.707416092075, 5363.410024897258, 5381.650192737459, 5383.488568585978, 4485.0, 4569.565891240327, 4579.923717926285, 4589.885252868638, 4667.649926255476, 5819.88360232793, 5833.300003999547, 5838.9124163137585, 5867.413258674099, 5890.263717035371, 6736.696848641823, 6821.556598821061, 6887.173539175331, 6900.551464154814, 6915.170179578382, 5830.3586605473365, 5841.269841269841, 5890.705464726747, 5892.911606325909, 5909.852253693606, 5698.943010569841, 5823.068309070529, 5840.1239814027385, 5917.053271476543, 5919.467247947706, 6555.475561955032, 6570.868582628321, 6587.63767992765, 6643.10318107059, 6643.269240383554, 6788.49086318538, 6794.830129246809, 6811.489138314547, 6868.313168683092, 6887.242403335629, 6400.199975003125, 6528.543001989815, 6546.901796472961, 6620.801375958729, 6644.800655980328, 6648.468122550088, 6722.361375669304, 6762.594244345355, 6767.627780472121, 6770.221424536241, 6694.866102677822, 6802.591844489347, 6830.965845170742, 6878.7248510059035, 6905.93094069073, 6421.357864213542, 6445.967770161306, 6530.738770449128, 6585.5719378240265, 6657.034729964032, 6606.174228221473, 6665.400113989765, 6681.064650948968, 6685.331466853276, 6697.899531507129, 6339.683015849097, 6430.0, 6474.0612611172055, 6512.511561632802, 6613.074169616354, 6508.316626754123, 6538.803835884931, 6552.3447655234095, 6566.507511936719, 6571.277159512354, 6312.400321969406, 6413.390727880844, 6441.420272175526, 6469.45009674183, 6495.447886929664], "value": 6165.768634904993, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [862.396322574198, 885.8449771290022, 889.0176355127584, 890.9866352004719, 893.2050475077178, 37716.24567508648, 38364.616353836456, 38417.0, 41680.79159604198, 41849.7907510462, 38391.808040959826, 38434.23131537375, 38462.8076859616, 38598.4210236846, 38807.61192388075, 7000.789976300706, 7103.325184107502, 7115.78652640419, 7116.181639111491, 7700.4609677322605, 7700.499467534621, 7819.374450044012, 7819.648115834772, 7822.335101516378, 7825.647845846951, 7790.9610451947665, 7831.177726338738, 7847.372210223197, 7849.25432083954, 7854.567998760066, 7799.5710235937, 7830.412719046038, 7830.530168189898, 7840.960795195988, 7842.725504607311, 7726.266004729542, 7743.806404839867, 7764.029496312961, 7789.337906277973, 7796.4932279401655, 37376.065598359986, 37422.0, 37452.0, 37651.623483765085, 37682.24635507275, 3527.770694904823, 3567.2152126532383, 3568.2685049564775, 3576.8032758198287, 3581.4269716845442, 31002.68997310043, 31003.534946975815, 31158.532622010687, 31257.218569535715, 31286.0, 5106.514881086328, 5138.997895410396, 5168.896622067575, 5174.2238664200295, 5211.1922651989, 185792.0, 185963.0, 186310.0, 186478.0, 186482.0, 47554.52445475501, 47641.0, 47703.5229647706, 47845.76077119662, 47884.5211547887, 44261.778691106985, 45116.0, 49906.50093499091, 50578.49421505811, 50595.74702126466, 16075.517734467985, 16351.345946162259, 16371.09958952269, 16398.508044758677, 16409.753853691964, 13324.800127998087, 13335.799963000563, 13353.132046416951, 13466.528671496646, 13491.055626106274, 13859.653508662364, 13898.861011389758, 14042.227677477633, 14115.082519636397, 14188.219647919463, 5605.775768969195, 5630.746616402272, 5753.194552762617, 5759.0, 5830.416958304136, 981.5288661442547, 994.2195376629311, 1001.3841487485145, 1008.5562352564848, 1017.1811691588342, 22256.0, 22372.664410033864, 22390.216342427935, 22675.75283359431, 22748.43128921757, 1106.1980064453207, 1107.9169062320198, 1108.6009036746764, 1114.3202646385698, 1118.1837258800958, 11974.341411222467, 12014.0, 12058.939705301418, 12131.818022729665, 12205.877941220651, 219134.0, 220586.0, 220789.0, 220807.0, 220876.0, 52341.7382913083, 52529.212061819104, 52537.211941820904, 52732.0, 52846.0, 1409.1685905315912, 1442.4446588063672, 1447.5440236325524, 1465.0403985389587, 1476.328270636879, 22165.88917055469, 22468.32595022152, 22469.662955056014, 22547.43631409162, 22605.208817691302, 35969.0, 36481.08797279983, 36484.45273320849, 36551.63448365482, 36634.63365366312, 184297.0, 184695.0, 184855.0, 185964.0, 186261.0, 33670.32659346848, 35438.0, 36049.459258111674, 36148.4577731329, 36152.819235903655, 45119.7744011291, 46160.53839461562, 46312.0, 46316.30525542052, 46463.53536464592, 33857.322853543286, 33956.32087358288, 33977.66022339745, 34335.828320858236, 34503.4824477638, 33216.66783332136, 33575.0, 33911.0, 34515.13712157216, 34576.654233457346, 37249.627503724616, 37529.0, 37553.6244637561, 37561.43657845189, 37626.62373376341, 32744.181395465304, 33078.83460582778, 33220.33559328751, 33241.667583323855, 33330.33339333248, 24538.141165059136, 24618.630720538848, 24626.138085166935, 24956.0017599294, 25218.0], "value": 17132.252768597824, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.5815580159081, 561.2731512691065, 571.0520535910389, 571.4628249445518, 575.839683038677, 21780.89109554452, 22830.657540136912, 22854.771452285473, 22868.31395058147, 22871.656925146137, 23600.881995589996, 24455.266342009767, 24841.25476235716, 25531.74468255317, 25677.486450270982, 6538.509611779112, 6607.306232845554, 6638.468922486214, 6652.667366631673, 6652.800415987504, 6523.836904077389, 6622.93377066228, 6629.9668501657425, 6632.933670663304, 6638.502112341594, 6375.521835862306, 6575.901361479581, 6589.04458853466, 6649.468042556584, 6656.833579160536, 6631.237407698104, 6658.4673226141795, 6661.467082633378, 6674.16572928384, 6680.231773346079, 6166.876662466726, 6195.256569211679, 6204.6587437690905, 6206.844828879269, 6219.0, 28310.292242693893, 29354.853225733947, 29392.41215175706, 29407.2648183795, 29510.852445737848, 2040.36748607932, 2088.081244252524, 2090.8640938339113, 2091.1426315210692, 2092.3095378525204, 19056.71414928777, 19595.90202048995, 19738.60522789536, 19832.603347933105, 19886.70169947452, 2422.6123820188686, 2428.878556072207, 2501.0371007162194, 2508.6989561252585, 2519.60946053362, 120971.39514302372, 126889.0, 131815.0, 138353.3082334592, 138949.61050389468, 14521.550019770577, 14563.635909102146, 14679.77980330296, 14772.177951868962, 14798.96407251482, 23106.8844655779, 23108.88445557795, 23120.190793322152, 23157.768422315563, 23168.65247021296, 10277.794444111225, 10342.120919721758, 10454.11140053104, 10459.94770026145, 10597.62908298206, 9872.802543949081, 9943.850842237372, 9952.402855828674, 9976.401415915068, 10012.949935250277, 8746.212840844228, 8787.868181977276, 8924.419912705653, 8978.281737460988, 9305.720828375159, 2651.3371657085727, 2678.2012796627573, 2704.648395708545, 2736.8094878727816, 2773.639426874534, 937.9390339627903, 967.2929714683424, 969.1634352901212, 972.4797233480195, 973.9220862331139, 19268.518287042934, 19359.612807744048, 19561.804381956284, 19608.21567137327, 19884.105215265346, 976.7216343342113, 1008.470552959702, 1012.3470361616863, 1016.3241444439365, 1021.7854250607455, 10485.318454300446, 10507.527161277761, 10590.209483784452, 10753.085987690978, 10970.561177552969, 441974.0, 451378.0, 452597.0, 457760.0, 461745.0, 106381.46809265904, 109836.0, 110430.0, 112302.0, 112894.0, 1002.0380434782545, 1130.7851508213414, 1156.809126494119, 1165.4522374484147, 1170.5727409495473, 19880.50298742543, 20466.38600841977, 20489.180432782523, 20499.590008199455, 20597.52730167405, 54682.45317546774, 55520.167197492876, 56310.0, 56498.0, 58400.70799645974, 69841.30158698552, 69977.0, 70722.64638676774, 71007.0, 71140.64429677819, 14153.08004979673, 14257.0, 14281.214533200773, 14343.713125737218, 14352.138871667734, 22208.888955555118, 22242.0, 22310.330690079325, 22856.428589285402, 22941.426464338525, 16999.83000170032, 17767.822321776617, 17892.373766918095, 18223.362182323555, 18368.90815545967, 15874.444394446138, 16062.59843503875, 16513.0, 16626.75059874127, 16666.083365414535, 17886.74792764494, 18136.365227216986, 18452.35416760407, 18561.257549698403, 18663.253469861596, 14052.508162214273, 14192.503262385768, 14218.289085545475, 14220.928895355457, 14243.501477448239, 18087.819121808614, 18209.635807284045, 18219.180136894138, 18373.724394134366, 18374.448766537025], "value": 11893.953449249917, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.6801083734483, 1381.9239941803203, 1395.4209003263645, 1402.495101763365, 1404.2206575350676, 14720.116792992429, 15384.615384615376, 15387.846121538782, 15401.845981540182, 15419.306131224093, 14867.851321486782, 15157.393704251845, 15273.159976201305, 15284.0, 15284.0, 2760.3789147441867, 2780.8470534120665, 2827.915162545127, 2832.957505637417, 2840.162152165106, 2680.1825443239804, 2770.515159847029, 2783.7633801126926, 2790.372166262595, 2794.9860250698716, 2308.0998410619873, 2404.362843846382, 2406.987965060181, 2762.599423083652, 2797.146870204587, 2776.1671498550454, 2826.9293267668268, 2852.9001484948135, 2855.8286502809897, 2858.4997625415467, 2606.609008648699, 2630.7500787425165, 2649.1125472966387, 2663.853488058156, 2677.143314139476, 14668.779968300483, 14803.0378025428, 14867.256637168206, 14877.18175500347, 14897.404103835834, 7953.323967462773, 8198.42611017229, 8199.098099209083, 8267.958660206721, 8272.33821294295, 5271.288376069258, 5579.832605021856, 5780.9710951445395, 5781.4507621775865, 5812.738426770806, 1911.2355057976781, 1913.6746753052014, 1918.0889077687987, 1983.8456853602697, 1995.4213278149318, 26366.73633263681, 26480.73519264821, 26550.6017409739, 26625.866870665715, 26672.733272667218, 7189.317014883578, 7214.891776623354, 7277.417806575567, 7467.701291948261, 7505.211952744992, 19522.219111235674, 19668.606627867364, 19688.114034868464, 19703.211871525265, 19703.310384136486, 8219.178082191853, 8234.382421318305, 8249.257566818895, 8252.21603947624, 8257.793555161048, 7036.050133231948, 7403.85192296151, 7491.513051651626, 7503.474756767083, 7514.47398682087, 5417.241586177938, 5691.630044047124, 5739.282589676291, 5741.96644603967, 5777.971110144423, 1567.968640627181, 1603.6311648320718, 1615.200475764504, 1747.8689098317677, 1841.1530695879778, 884.6638277454655, 898.5686870302292, 907.265115256631, 907.5862480304882, 913.9223166030829, 8725.389222754473, 8735.694250701195, 8742.0, 8776.956115219384, 8842.115788421235, 977.5796407544682, 982.1504398695077, 993.3841018568389, 993.7068564773265, 1002.1460298447813, 5287.576993840484, 5321.441248668912, 5403.918941215885, 5437.293151890308, 5478.780848766084, 21311.25410610621, 22685.319440416813, 22685.546289074126, 22714.318570442912, 22772.31683049511, 20843.478913027295, 21821.890890545445, 22046.0, 22065.669014964787, 22385.888070559544, 10331.690049298382, 10373.896261037444, 10429.68710938673, 10464.686059418229, 10481.685549433529, 7978.0825205102155, 8608.311335093304, 8616.439931404439, 8768.167024132697, 8773.956130219309, 18222.908885455487, 18828.905855471185, 18913.148908298885, 18914.905425473335, 19289.421317360502, 19338.22647094157, 19338.613227735084, 19613.901930490258, 19932.20271189136, 19972.20111195594, 10890.455477226265, 10903.563857445613, 10998.285111467729, 11009.229353945468, 11012.834807478055, 13811.240381779098, 13935.721285574435, 14085.859141408455, 14090.084144530572, 14093.647658808612, 11182.0, 11311.71720706956, 11368.886311137114, 11589.942050289694, 11704.590339338083, 11096.0, 11261.774764504828, 11339.206255562032, 11385.203035787416, 11449.771004579696, 10022.098011179029, 10109.64616238428, 10246.795064098826, 10252.282340236112, 10259.435731034864, 7405.629718513945, 7413.703451861865, 7414.073240844895, 7482.812929676584, 7525.096988361432, 7163.7492687755675, 7237.095363079615, 7270.9636451817405, 7314.634268286671, 7322.450816188701], "value": 6819.256866799117, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.7581023203746, 512.088482501148, 529.7457220534144, 531.7102179312275, 540.0468173673466, 6280.4661603763625, 6333.429991300782, 6338.587991780537, 6346.968265158668, 6399.328070552595, 6261.843453913654, 6271.184745983027, 6281.43467087962, 6297.118403423513, 6327.330148513863, 5193.195054766507, 5210.348706411699, 5213.687178769286, 5245.606579506533, 5258.421573626898, 5057.013882292954, 5151.201563757623, 5233.4243233244315, 5261.552768014723, 5274.709890955995, 4772.80908763649, 4908.631852611051, 4952.851414457572, 4963.305137280783, 4981.975090124544, 4938.629602779788, 4939.209726443788, 4943.6539442239055, 4979.278004689336, 4982.87542811429, 4319.330503771889, 4414.205443020255, 4426.424564806554, 4426.535213802569, 4430.800613972379, 6018.909716354258, 6058.485028772516, 6128.7242074106325, 6134.325224225332, 6165.876682466371, 5688.009196781093, 5688.232088668018, 5691.886162276731, 5698.715064246771, 5712.428757124254, 6444.194475690539, 6540.607563546155, 6562.114114594517, 6567.244766851825, 6570.408663220285, 4651.162790697673, 4885.728136416547, 4888.193448081062, 4909.754512274372, 4912.115819152551, 6680.799576012728, 6773.627450490221, 6837.837567613517, 6879.140107486614, 6883.931160688379, 4980.327655766425, 4996.050750357421, 5002.52476014778, 5005.6996580205305, 5038.168702164176, 5011.57401620859, 5029.346184995927, 5047.747612619354, 5050.797968081309, 5083.949160508421, 5571.9442805572235, 5645.717714114277, 5652.0674088774895, 5665.461781130786, 5665.5467562594895, 6558.704858281389, 6601.095517972077, 6603.900941485882, 6627.138471998609, 6642.368974947372, 1749.4314347837003, 1750.2036573359092, 1751.3957684598793, 1764.7823002128746, 1767.8674099442594, 1138.5218208352512, 1182.5742732616252, 1200.153891506486, 1217.598192596441, 1222.10175520992, 5600.85997850057, 5627.493525582717, 5659.801906933238, 5668.206451096849, 5719.026935707175, 6537.640429776313, 6636.63948890486, 6684.86630267392, 6722.865542689216, 6765.8646827063185, 5593.328800543961, 5625.324961004706, 5644.491995720405, 5652.547796176296, 5699.090804580512, 3442.0, 3554.751167418256, 3564.946525802115, 3575.1598374382, 3589.1565482111682, 6299.212598425197, 6349.301546842574, 6452.35476452351, 6461.61230326182, 6485.4163125318, 6744.494162937701, 6809.897851532231, 6814.046033555306, 6830.146231721035, 6847.6446541194455, 6383.755167742339, 6405.967970160213, 6462.256840463407, 6486.156799616019, 6496.415322620986, 6240.1903448001385, 6484.383983521558, 6611.537192396486, 6623.437007854193, 6639.937609982379, 6405.647689376942, 6461.773837915838, 6529.836754081186, 6543.312952139957, 6581.868362632817, 6249.656268905072, 6258.436740693177, 6344.651044192429, 6368.9044664330995, 6383.489320854414, 4908.263760435821, 4914.36113305268, 4926.162552366035, 4935.75321233944, 4951.925721114114, 6406.423421892052, 6497.913491091883, 6519.4132528072705, 6655.633940133339, 6692.230393504809, 6243.37566243372, 6483.254425740912, 6500.772472963424, 6508.704255191551, 6512.479001679949, 6480.57876238043, 6495.935040649533, 6512.120863683342, 6526.934730652632, 6529.118568993125, 6321.494280457644, 6416.197975253093, 6425.839354016187, 6428.389303016206, 6434.324395938359, 6536.346365363425, 6561.507886908596, 6587.341265873374, 6589.703463344257, 6597.0764093026055, 6387.169667943138, 6391.968040159955, 6413.35866413355, 6429.678516074271, 6452.612843229421], "value": 5035.157137915673, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [882.3162049411706, 882.858742601184, 907.2560500389679, 921.1479381572049, 923.247553244106, 16910.915445422772, 17663.381781637647, 17692.557686057855, 17702.822971770278, 17760.289588416465, 16001.119938403383, 16008.919955400206, 16220.918895405506, 16281.511554653349, 17215.655686886254, 964.9903500965006, 974.6442548469828, 979.2606582030556, 979.4661909259471, 979.5004547680699, 975.7560609847538, 981.4062492192228, 983.8179936711696, 986.3884391677134, 986.866772985645, 998.9300748947541, 1024.3751311699857, 1031.3554028732042, 1042.525650828871, 1046.2780681329857, 1007.9798404031951, 1014.9035841595111, 1017.3793985668736, 1017.7557386227326, 1018.1854516386861, 710.5914099392818, 739.0429393934867, 741.4365082537256, 745.7352639812842, 749.5015814483362, 17828.643427131385, 18021.549461263443, 18035.0, 18039.0, 18059.187336569754, 18365.7245141323, 18514.0, 18585.535361615934, 19090.904545477184, 19095.331663391855, 17119.91440042792, 17499.0, 17583.824161758475, 17612.0, 17823.643527129385, 3757.0, 3778.886633401002, 3781.3004594149897, 3783.5459744830523, 3784.2242340320167, 138418.0, 138907.99999999898, 138915.0, 142739.28630356886, 142849.2857535716, 16574.6685066298, 16698.248578813982, 16802.747958780627, 16859.578510537336, 16935.32258709638, 31073.0, 31506.0, 31531.36937261242, 31553.211169720482, 31631.367372652418, 8829.470231786114, 8830.116988301246, 8843.425177363579, 8917.019127895926, 8920.063393343735, 4193.559676234013, 4286.957130428718, 4294.377315289265, 4307.224699554048, 4312.54718254585, 5348.732563371816, 5464.153056276284, 5483.396826349099, 5500.614956952975, 5522.199281104217, 971.8736564246602, 996.8355221388534, 1006.5420233793607, 1009.6163457885956, 1016.9593216271414, 694.5728377048079, 702.7610612391709, 705.989410158848, 709.8438343564408, 715.9069320988239, 10922.890771092347, 11298.322100673822, 11339.886601133883, 11984.64046078619, 12186.146969712036, 682.8804959132132, 686.9072675188786, 701.8034950213948, 704.3871831506622, 704.63359053292, 5446.673199608036, 5452.345718513804, 5539.41836107211, 5639.2668953035845, 5642.322921249476, 114139.0, 115784.42107789408, 117845.0, 119886.0, 120028.0, 104896.95103049025, 105831.0, 106905.0, 108015.0, 108684.0, 94630.52684736533, 95443.52278238564, 96169.0, 98590.5070474643, 99776.0, 10242.334248273839, 10382.532786024496, 10448.843267351147, 10475.423851687925, 10553.630622928467, 43332.566674332855, 44569.0, 44772.32841507445, 45370.77314613406, 45981.540184597725, 56316.7184164093, 56535.43464565466, 56864.0, 57218.42781572298, 58759.70620146872, 15180.696386072437, 15597.844021559638, 15653.139077350856, 15702.607434814221, 15861.444849430676, 16499.0, 16713.749293760848, 16746.916265418597, 16781.832181678514, 17021.0, 16531.173441327646, 16539.66920661604, 16540.917295413445, 16650.084245366623, 16731.163441828103, 15955.0, 16333.673326533166, 16431.0, 16431.589210269838, 16503.504894853173, 14880.255987200813, 14935.775963360342, 14978.1013139212, 15102.848971510144, 15172.696546069237, 11336.376499292619, 11611.941940290244, 11640.417979101181, 11749.353785541878, 11998.700032499257, 10067.1442927352, 10254.92323306042, 10317.638882639072, 10410.375377477376, 10498.790024199321], "value": 8763.590233596105, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1423.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 109.0, 109.0, 107.0, 108.0, 110.0, 108.0, 108.0, 108.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 116.0, 119.0, 118.0, 115.0, 117.0, 116.0, 115.0, 119.0], "value": 116.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 167.0, 164.0, 163.0, 162.0, 167.0, 167.0, 163.0, 169.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 72.0, 73.0, 73.0, 74.0, 72.0, 76.0, 75.0, 75.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 80.0, 80.0, 81.0, 79.0, 79.0, 79.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 113.0, 113.0, 113.0, 115.0, 114.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 149.0, 148.0, 148.0, 148.0, 150.0, 148.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 96.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 55.0, 60.0, 52.0, 52.0, 52.0, 51.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 75.0, 80.0, 74.0, 76.0, 75.0, 76.0, 74.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 126.0, 113.0, 111.0, 115.0, 119.0, 111.0, 110.0, 117.0, 111.0], "value": 114.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 169.0, 166.0, 166.0, 170.0, 174.0, 177.0, 176.0, 187.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 67.0, 67.0, 66.0, 68.0, 68.0, 67.0, 65.0, 71.0], "value": 67.8, "unit": "score"}]}]} 03:19:21 INFO - Return code: 0 03:19:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:19:21 INFO - # TBPL SUCCESS # 03:19:21 INFO - Running post-action listener: _package_coverage_data 03:19:21 INFO - Running post-action listener: _resource_record_post_action 03:19:21 INFO - [mozharness: 2017-09-15 10:19:21.159975Z] Finished run-tests step (success) 03:19:21 INFO - Running post-run listener: _resource_record_post_run 03:19:21 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 348258304; Read time: 8; Write time: 196348 03:19:21 INFO - TinderboxPrint: CPU usage
13.1% 03:19:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 03:19:21 INFO - TinderboxPrint: I/O write bytes / time
348,258,304 / 196,348 03:19:21 INFO - TinderboxPrint: CPU idle
8,249.3 (86.9%) 03:19:21 INFO - TinderboxPrint: CPU user
1,194.5 (12.6%) 03:19:21 INFO - TinderboxPrint: Swap in / out
0 / 0 03:19:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13205504; Read time: 0; Write time: 3112 03:19:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:19:21 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 335052800; Read time: 0; Write time: 193236 03:19:21 INFO - Running post-run listener: _upload_blobber_files 03:19:21 INFO - Blob upload gear active. 03:19:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:19:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:19:22 INFO - (blobuploader) - INFO - Open directory for files ... 03:19:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:19:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:19:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:23 INFO - (blobuploader) - INFO - Done attempting. 03:19:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:19:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:19:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:24 INFO - (blobuploader) - INFO - Done attempting. 03:19:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:19:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:19:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:25 INFO - (blobuploader) - INFO - Done attempting. 03:19:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:19:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:32 INFO - (blobuploader) - INFO - Done attempting. 03:19:32 INFO - (blobuploader) - INFO - Iteration through files over. 03:19:32 INFO - Return code: 0 03:19:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:19:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:19:32 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56a4b8e416708cdc6b6bfce3f41f93d9b86f8bc8bf6e44774c9d96cac183f2e10122c1b927d9d0d44e3ea32c52a3f4598c184142e9231e7bfa964f1d07246175", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d298c428f59f0fbfd5de6d11bdc6f994487ab9b8668374630667161a455b91a941b297f5b5f15d3c51e441dfd1d005495bb491f82587ba54ae0ae3f7259470f2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a268d7eecf345490ef0d37014e060922f78e1acd99efda8a3b3f730902dd8f50161b2e387fbc61ba67e0fb161efe7f41c27aa704cb0a43012e6fdc5c80189c01", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6672f45f46ae95e289f02f47d58e7786d013e3df603096bb996c75cfc5940f8db24d234a2f309a28d7a82fc7b04c8fc32f90da8dcfa0f00ab895cf4fe46a8826"} 03:19:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:19:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:19:32 INFO - Contents: 03:19:32 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56a4b8e416708cdc6b6bfce3f41f93d9b86f8bc8bf6e44774c9d96cac183f2e10122c1b927d9d0d44e3ea32c52a3f4598c184142e9231e7bfa964f1d07246175", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d298c428f59f0fbfd5de6d11bdc6f994487ab9b8668374630667161a455b91a941b297f5b5f15d3c51e441dfd1d005495bb491f82587ba54ae0ae3f7259470f2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a268d7eecf345490ef0d37014e060922f78e1acd99efda8a3b3f730902dd8f50161b2e387fbc61ba67e0fb161efe7f41c27aa704cb0a43012e6fdc5c80189c01", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6672f45f46ae95e289f02f47d58e7786d013e3df603096bb996c75cfc5940f8db24d234a2f309a28d7a82fc7b04c8fc32f90da8dcfa0f00ab895cf4fe46a8826"} 03:19:32 INFO - Running post-run listener: copy_logs_to_upload_dir 03:19:32 INFO - Copying logs to upload dir... 03:19:32 INFO - mkdir: /builds/slave/test/build/upload/logs 03:19:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.218448 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-15 03:19:32.668530) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 03:19:32.672128) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56a4b8e416708cdc6b6bfce3f41f93d9b86f8bc8bf6e44774c9d96cac183f2e10122c1b927d9d0d44e3ea32c52a3f4598c184142e9231e7bfa964f1d07246175", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d298c428f59f0fbfd5de6d11bdc6f994487ab9b8668374630667161a455b91a941b297f5b5f15d3c51e441dfd1d005495bb491f82587ba54ae0ae3f7259470f2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a268d7eecf345490ef0d37014e060922f78e1acd99efda8a3b3f730902dd8f50161b2e387fbc61ba67e0fb161efe7f41c27aa704cb0a43012e6fdc5c80189c01", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6672f45f46ae95e289f02f47d58e7786d013e3df603096bb996c75cfc5940f8db24d234a2f309a28d7a82fc7b04c8fc32f90da8dcfa0f00ab895cf4fe46a8826"} build_url:https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/56a4b8e416708cdc6b6bfce3f41f93d9b86f8bc8bf6e44774c9d96cac183f2e10122c1b927d9d0d44e3ea32c52a3f4598c184142e9231e7bfa964f1d07246175", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d298c428f59f0fbfd5de6d11bdc6f994487ab9b8668374630667161a455b91a941b297f5b5f15d3c51e441dfd1d005495bb491f82587ba54ae0ae3f7259470f2", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a268d7eecf345490ef0d37014e060922f78e1acd99efda8a3b3f730902dd8f50161b2e387fbc61ba67e0fb161efe7f41c27aa704cb0a43012e6fdc5c80189c01", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6672f45f46ae95e289f02f47d58e7786d013e3df603096bb996c75cfc5940f8db24d234a2f309a28d7a82fc7b04c8fc32f90da8dcfa0f00ab895cf4fe46a8826"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 03:19:32.701620) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:19:32.701986) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1505461054.567644-1839951433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:19:32.786905) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 03:19:32.787675) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 03:19:32.788372) ========= ========= Total master_lag: 0.19 =========