builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-069 starttime: 1505469480.81 results: success (0) revision: 893fe1549e1e7342a66514b65960f08d40810a34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:00.814875) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:00.820392) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:00.820704) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:00.916610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:00.916965) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-15 02:58:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.1M=0s 2017-09-15 02:58:01 (25.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.326594 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:01.378283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:01.378622) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.011515 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:01.425802) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 55 secs) (at 2017-09-15 02:58:01.429237) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-15 02:58:01,143 truncating revision to first 12 chars 2017-09-15 02:58:01,143 Setting DEBUG logging. 2017-09-15 02:58:01,143 attempt 1/10 2017-09-15 02:58:01,143 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:58:02,534 attempt 1/10 2017-09-15 02:58:03,063 current task status: no status available at this point. state: PENDING 2017-09-15 02:58:03,064 sleeping for 11.00s (attempt 1/10) 2017-09-15 02:58:14,075 attempt 2/10 2017-09-15 02:58:14,838 current task status: no status available at this point. state: PENDING 2017-09-15 02:58:14,838 sleeping for 16.50s (attempt 2/10) 2017-09-15 02:58:31,355 attempt 3/10 2017-09-15 02:58:32,185 current task status: no status available at this point. state: STARTED 2017-09-15 02:58:32,185 sleeping for 23.75s (attempt 3/10) 2017-09-15 02:58:55,959 attempt 4/10 2017-09-15 02:58:56,292 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-09-15 02:58:56,625 unpacking tar archive at: mozilla-central-893fe1549e1e/testing/mozharness/ program finished with exit code 0 elapsedTime=55.794177 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 55 secs) (at 2017-09-15 02:58:57.250100) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:57.250453) ========= script_repo_revision: 893fe1549e1e7342a66514b65960f08d40810a34 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:57.250861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:57.251139) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-15 02:58:57.264452) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-15 02:58:57.264719) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:58:57 INFO - MultiFileLogger online at 20170915 02:58:57 in /builds/slave/test 02:58:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:58:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:58:57 INFO - {'append_to_log': False, 02:58:57 INFO - 'base_work_dir': '/builds/slave/test', 02:58:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:58:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:58:57 INFO - 'branch': 'Firefox-Non-PGO', 02:58:57 INFO - 'buildbot_json_path': 'buildprops.json', 02:58:57 INFO - 'code_coverage': False, 02:58:57 INFO - 'config_files': ('talos/linux_config.py',), 02:58:57 INFO - 'default_actions': ('clobber', 02:58:57 INFO - 'read-buildbot-config', 02:58:57 INFO - 'download-and-extract', 02:58:57 INFO - 'populate-webroot', 02:58:57 INFO - 'create-virtualenv', 02:58:57 INFO - 'install', 02:58:57 INFO - 'setup-mitmproxy', 02:58:57 INFO - 'run-tests'), 02:58:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:58:57 INFO - 'disable_ccov_upload': False, 02:58:57 INFO - 'disable_stylo': False, 02:58:57 INFO - 'download_minidump_stackwalk': True, 02:58:57 INFO - 'download_symbols': 'ondemand', 02:58:57 INFO - 'enable_stylo': False, 02:58:57 INFO - 'enable_webrender': False, 02:58:57 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:58:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:58:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:58:57 INFO - 'gecko_profile': False, 02:58:57 INFO - 'gecko_profile_interval': 0, 02:58:57 INFO - 'installer_path': 'installer.exe', 02:58:57 INFO - 'log_level': 'info', 02:58:57 INFO - 'log_name': 'talos', 02:58:57 INFO - 'log_to_console': True, 02:58:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:58:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:58:57 INFO - 'opt_config_files': (), 02:58:57 INFO - 'pip_index': False, 02:58:57 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 02:58:57 INFO - 'system_bits': '32', 02:58:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:58:57 INFO - 'title': 'talos-linux64-ix-069', 02:58:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:58:57 INFO - 'use_talos_json': True, 02:58:57 INFO - 'verify': 'False', 02:58:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:58:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:58:57 INFO - 'work_dir': 'build'} 02:58:57 INFO - [mozharness: 2017-09-15 09:58:57.240005Z] Running clobber step. 02:58:57 INFO - Running pre-action listener: _resource_record_pre_action 02:58:57 INFO - Running main action method: clobber 02:58:57 INFO - rmtree: /builds/slave/test/build 02:58:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:58:58 INFO - Running post-action listener: _resource_record_post_action 02:58:58 INFO - [mozharness: 2017-09-15 09:58:58.184784Z] Finished clobber step (success) 02:58:58 INFO - [mozharness: 2017-09-15 09:58:58.184880Z] Running read-buildbot-config step. 02:58:58 INFO - Running pre-action listener: _resource_record_pre_action 02:58:58 INFO - Running main action method: read_buildbot_config 02:58:58 INFO - Using buildbot properties: 02:58:58 INFO - { 02:58:58 INFO - "project": "", 02:58:58 INFO - "product": "firefox", 02:58:58 INFO - "who": "archaeopteryx@coole-files.de", 02:58:58 INFO - "installer_path": "public/build/target.tar.bz2", 02:58:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 02:58:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:58:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 02:58:58 INFO - "stage_platform": "linux64", 02:58:58 INFO - "basedir": "/builds/slave/test", 02:58:58 INFO - "buildnumber": 24, 02:58:58 INFO - "platform": "ubuntu64_hw", 02:58:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:58:58 INFO - "slavebuilddir": "test", 02:58:58 INFO - "taskId": "X19gIhsaTEe2gKzCMiH8eg", 02:58:58 INFO - "branch": "mozilla-central", 02:58:58 INFO - "script_repo_revision": "production", 02:58:58 INFO - "revision": "893fe1549e1e7342a66514b65960f08d40810a34", 02:58:58 INFO - "slavename": "talos-linux64-ix-069", 02:58:58 INFO - "repo_path": "mozilla-central" 02:58:58 INFO - } 02:58:58 INFO - Finding installer, test and symbols from parent task. 02:58:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X19gIhsaTEe2gKzCMiH8eg'}, attempt #1 02:58:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X19gIhsaTEe2gKzCMiH8eg'}, attempt #1 02:58:59 INFO - Task dependencies: VYH2wZ13SaWnxkKe49_76g 02:58:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g'}, attempt #1 02:58:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.tar.bz2 02:58:59 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.test_packages.json 02:58:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.crashreporter-symbols.zip 02:58:59 INFO - Running post-action listener: _resource_record_post_action 02:58:59 INFO - [mozharness: 2017-09-15 09:58:59.614173Z] Finished read-buildbot-config step (success) 02:58:59 INFO - [mozharness: 2017-09-15 09:58:59.614428Z] Running download-and-extract step. 02:58:59 INFO - Running pre-action listener: _resource_record_pre_action 02:58:59 INFO - Running main action method: download_and_extract 02:58:59 INFO - mkdir: /builds/slave/test/build/tests 02:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:59 INFO - trying https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.test_packages.json 02:58:59 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:59 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:59:00 INFO - Downloaded 989 bytes. 02:59:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:59:00 INFO - Using the following test package requirements: 02:59:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:59:00 INFO - u'common': [u'target.common.tests.zip'], 02:59:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:59:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:59:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:59:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:59:00 INFO - u'mozbase': [u'target.common.tests.zip'], 02:59:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:59:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:59:00 INFO - u'web-platform': [u'target.common.tests.zip', 02:59:00 INFO - u'target.web-platform.tests.tar.gz'], 02:59:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:59:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:59:00 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:59:00 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:59:00 INFO - Fetch https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.common.tests.zip into memory 02:59:01 INFO - Content-Length response header: 54736771 02:59:01 INFO - Bytes received: 54736771 02:59:12 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:12 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:12 INFO - Fetch https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.talos.tests.zip into memory 02:59:13 INFO - Content-Length response header: 14502661 02:59:13 INFO - Bytes received: 14502661 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 - trying https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.tar.bz2 02:59:13 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:13 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:14 INFO - Downloaded 61595327 bytes. 02:59:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.tar.bz2 02:59:14 INFO - mkdir: /builds/slave/test/properties 02:59:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:59:14 INFO - Writing to file /builds/slave/test/properties/build_url 02:59:14 INFO - Contents: 02:59:14 INFO - build_url:https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.tar.bz2 02:59:14 INFO - Running post-action listener: _resource_record_post_action 02:59:14 INFO - Running post-action listener: find_tests_for_verification 02:59:14 INFO - Running post-action listener: set_extra_try_arguments 02:59:14 INFO - [mozharness: 2017-09-15 09:59:14.933047Z] Finished download-and-extract step (success) 02:59:14 INFO - [mozharness: 2017-09-15 09:59:14.933144Z] Running populate-webroot step. 02:59:14 INFO - Running pre-action listener: _resource_record_pre_action 02:59:14 INFO - Running main action method: populate_webroot 02:59:14 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:59:14 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:14 INFO - 'tests': ['tresize', 02:59:14 INFO - 'tcanvasmark']}, 02:59:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:59:14 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:14 INFO - 'tests': ['dromaeo_css', 02:59:14 INFO - 'kraken']}, 02:59:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:59:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:14 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:14 INFO - 'talos_options': ['--disable-stylo'], 02:59:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:59:14 INFO - 'tests': ['damp', 'tps']}, 02:59:14 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:14 INFO - 'talos_options': ['--disable-stylo'], 02:59:14 INFO - 'tests': ['damp', 'tps']}, 02:59:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:14 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:14 INFO - 'tests': ['dromaeo_dom']}, 02:59:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:59:14 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:14 INFO - 'tests': ['basic_compositor_video', 02:59:14 INFO - 'glvideo']}, 02:59:14 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:59:14 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:59:14 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:14 INFO - 'talos_options': ['--disable-stylo'], 02:59:14 INFO - 'tests': ['ts_paint_webext', 02:59:14 INFO - 'tp5o_webext']}, 02:59:14 INFO - 'other-e10s': {'tests': ['a11yr', 02:59:14 INFO - 'ts_paint', 02:59:14 INFO - 'tpaint', 02:59:14 INFO - 'sessionrestore', 02:59:14 INFO - 'sessionrestore_many_windows', 02:59:14 INFO - 'sessionrestore_no_auto_restore', 02:59:14 INFO - 'tabpaint']}, 02:59:14 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:14 INFO - 'tests': ['a11yr', 02:59:14 INFO - 'ts_paint', 02:59:14 INFO - 'tpaint', 02:59:14 INFO - 'sessionrestore', 02:59:14 INFO - 'sessionrestore_many_windows', 02:59:14 INFO - 'sessionrestore_no_auto_restore', 02:59:14 INFO - 'tabpaint']}, 02:59:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:59:14 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:59:14 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:14 INFO - 'tests': ['bloom_basic_singleton']}, 02:59:14 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:14 INFO - 'tests': ['bloom_basic']}, 02:59:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:59:14 INFO - 'tsvgr_opacity', 02:59:14 INFO - 'tart', 02:59:14 INFO - 'tscrollx', 02:59:14 INFO - 'tsvg_static']}, 02:59:14 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:59:14 INFO - 'tests': ['tsvgx', 02:59:14 INFO - 'tsvgr_opacity', 02:59:14 INFO - 'tart', 02:59:14 INFO - 'tscrollx', 02:59:14 INFO - 'tsvg_static']}, 02:59:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:59:14 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:14 INFO - 'talos_options': ['--disable-stylo'], 02:59:14 INFO - 'tests': ['tp5o']}, 02:59:14 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:59:14 INFO - 'talos_options': ['--mitmproxy', 02:59:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:59:14 INFO - '--firstNonBlankPaint'], 02:59:14 INFO - 'tests': ['tp6_google', 02:59:14 INFO - 'tp6_youtube', 02:59:14 INFO - 'tp6_amazon', 02:59:14 INFO - 'tp6_facebook']}, 02:59:14 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:59:14 INFO - 'talos_options': ['--disable-stylo', 02:59:14 INFO - '--mitmproxy', 02:59:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:59:14 INFO - '--firstNonBlankPaint'], 02:59:14 INFO - 'tests': ['tp6_google', 02:59:14 INFO - 'tp6_youtube', 02:59:14 INFO - 'tp6_amazon', 02:59:14 INFO - 'tp6_facebook']}, 02:59:14 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:59:14 INFO - 'talos_options': ['--stylo-threads=1', 02:59:14 INFO - '--mitmproxy', 02:59:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:59:14 INFO - '--firstNonBlankPaint'], 02:59:14 INFO - 'tests': ['tp6_google', 02:59:14 INFO - 'tp6_youtube', 02:59:14 INFO - 'tp6_amazon', 02:59:14 INFO - 'tp6_facebook']}, 02:59:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:59:14 INFO - 'talos_options': ['--xperf_path', 02:59:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:14 INFO - 'tests': ['tp5n']}, 02:59:14 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:59:14 INFO - 'talos_options': ['--disable-stylo', 02:59:14 INFO - '--xperf_path', 02:59:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:14 INFO - 'tests': ['tp5n']}}} 02:59:14 INFO - Running post-action listener: _resource_record_post_action 02:59:14 INFO - [mozharness: 2017-09-15 09:59:14.948026Z] Finished populate-webroot step (success) 02:59:14 INFO - [mozharness: 2017-09-15 09:59:14.948115Z] Running create-virtualenv step. 02:59:14 INFO - Running pre-action listener: _resource_record_pre_action 02:59:14 INFO - Running main action method: create_virtualenv 02:59:14 INFO - Creating virtualenv /builds/slave/test/build/venv 02:59:14 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:59:14 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:59:14 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:59:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:59:15 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:16 INFO - Installing pip...............done. 02:59:16 INFO - Return code: 0 02:59:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:59:16 INFO - Reading from file tmpfile_stdout 02:59:16 INFO - Output received: 02:59:16 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:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:59:16 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:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:16 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:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:16 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 0x10fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e090>, '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 0x146ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1468f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', '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:16 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:16 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:16 INFO - Using env: {'DISPLAY': ':0', 02:59:16 INFO - 'HOME': '/home/cltbld', 02:59:16 INFO - 'LANG': 'en_US.UTF-8', 02:59:16 INFO - 'LANGUAGE': 'en_US:en', 02:59:16 INFO - 'LOGNAME': 'cltbld', 02:59:16 INFO - 'MAIL': '/var/mail/cltbld', 02:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:16 INFO - 'MOZ_NO_REMOTE': '1', 02:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:16 INFO - 'NO_EM_RESTART': '1', 02:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:16 INFO - 'PWD': '/builds/slave/test', 02:59:16 INFO - 'SHELL': '/bin/bash', 02:59:16 INFO - 'SHLVL': '1', 02:59:16 INFO - 'TERM': 'linux', 02:59:16 INFO - 'TMOUT': '86400', 02:59:16 INFO - 'USER': 'cltbld', 02:59:16 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', 02:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:16 INFO - '_': '/tools/buildbot/bin/python'} 02:59:19 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:59:19 INFO - Downloading/unpacking pip>=1.5 02:59:19 INFO - Running setup.py egg_info for package pip 02:59:19 INFO - warning: no files found matching 'pip/cacert.pem' 02:59:19 INFO - warning: no files found matching '*.html' under directory 'docs' 02:59:19 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:59:19 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:59:19 INFO - Installing collected packages: pip 02:59:19 INFO - Found existing installation: pip 1.1 02:59:19 INFO - Uninstalling pip: 02:59:19 INFO - Successfully uninstalled pip 02:59:19 INFO - Running setup.py install for pip 02:59:19 INFO - warning: no files found matching 'pip/cacert.pem' 02:59:19 INFO - warning: no files found matching '*.html' under directory 'docs' 02:59:19 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:59:19 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:59:19 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:59:19 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:59:19 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:59:19 INFO - Successfully installed pip 02:59:19 INFO - Cleaning up... 02:59:19 INFO - Return code: 0 02:59:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:59:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:19 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 0x10fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e090>, '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 0x146ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1468f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 02:59:19 INFO - 'HOME': '/home/cltbld', 02:59:19 INFO - 'LANG': 'en_US.UTF-8', 02:59:19 INFO - 'LANGUAGE': 'en_US:en', 02:59:19 INFO - 'LOGNAME': 'cltbld', 02:59:19 INFO - 'MAIL': '/var/mail/cltbld', 02:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:19 INFO - 'MOZ_NO_REMOTE': '1', 02:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:19 INFO - 'NO_EM_RESTART': '1', 02:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:19 INFO - 'PWD': '/builds/slave/test', 02:59:19 INFO - 'SHELL': '/bin/bash', 02:59:19 INFO - 'SHLVL': '1', 02:59:19 INFO - 'TERM': 'linux', 02:59:19 INFO - 'TMOUT': '86400', 02:59:19 INFO - 'USER': 'cltbld', 02:59:19 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', 02:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:19 INFO - '_': '/tools/buildbot/bin/python'} 02:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:20 INFO - Downloading/unpacking psutil>=3.1.1 02:59:20 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:20 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:20 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:20 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:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:21 INFO - Installing collected packages: psutil 02:59:21 INFO - Running setup.py install for psutil 02:59:21 INFO - building 'psutil._psutil_linux' extension 02:59:21 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:22 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:22 INFO - building 'psutil._psutil_posix' extension 02:59:22 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:22 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:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:22 INFO - Successfully installed psutil 02:59:22 INFO - Cleaning up... 02:59:22 INFO - Return code: 0 02:59:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:59:22 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:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:22 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:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:22 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 0x10fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e090>, '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 0x146ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1468f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 02:59:22 INFO - 'HOME': '/home/cltbld', 02:59:22 INFO - 'LANG': 'en_US.UTF-8', 02:59:22 INFO - 'LANGUAGE': 'en_US:en', 02:59:22 INFO - 'LOGNAME': 'cltbld', 02:59:22 INFO - 'MAIL': '/var/mail/cltbld', 02:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:22 INFO - 'MOZ_NO_REMOTE': '1', 02:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:22 INFO - 'NO_EM_RESTART': '1', 02:59:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:22 INFO - 'PWD': '/builds/slave/test', 02:59:22 INFO - 'SHELL': '/bin/bash', 02:59:22 INFO - 'SHLVL': '1', 02:59:22 INFO - 'TERM': 'linux', 02:59:22 INFO - 'TMOUT': '86400', 02:59:22 INFO - 'USER': 'cltbld', 02:59:22 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', 02:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:22 INFO - '_': '/tools/buildbot/bin/python'} 02:59:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:59:22 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:22 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:22 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:22 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:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:59:24 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:24 INFO - Installing collected packages: mozsystemmonitor 02:59:24 INFO - Running setup.py install for mozsystemmonitor 02:59:24 INFO - Successfully installed mozsystemmonitor 02:59:24 INFO - Cleaning up... 02:59:24 INFO - Return code: 0 02:59:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:59:24 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:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:24 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:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:24 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 0x10fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e090>, '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 0x146ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1468f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', '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:24 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:24 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:24 INFO - Using env: {'DISPLAY': ':0', 02:59:24 INFO - 'HOME': '/home/cltbld', 02:59:24 INFO - 'LANG': 'en_US.UTF-8', 02:59:24 INFO - 'LANGUAGE': 'en_US:en', 02:59:24 INFO - 'LOGNAME': 'cltbld', 02:59:24 INFO - 'MAIL': '/var/mail/cltbld', 02:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:24 INFO - 'MOZ_NO_REMOTE': '1', 02:59:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:24 INFO - 'NO_EM_RESTART': '1', 02:59:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:24 INFO - 'PWD': '/builds/slave/test', 02:59:24 INFO - 'SHELL': '/bin/bash', 02:59:24 INFO - 'SHLVL': '1', 02:59:24 INFO - 'TERM': 'linux', 02:59:24 INFO - 'TMOUT': '86400', 02:59:24 INFO - 'USER': 'cltbld', 02:59:24 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', 02:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:24 INFO - '_': '/tools/buildbot/bin/python'} 02:59:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:24 INFO - Downloading/unpacking jsonschema==2.5.1 02:59:24 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:24 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:24 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:24 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 - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:59:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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:25 INFO - Downloading functools32-3.2.3-2.tar.gz 02:59:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:59:25 INFO - warning: no files found matching '*.txt' 02:59:25 INFO - no previously-included directories found matching 'build' 02:59:25 INFO - no previously-included directories found matching 'dist' 02:59:25 INFO - no previously-included directories found matching '.git*' 02:59:25 INFO - Installing collected packages: jsonschema, functools32 02:59:25 INFO - Running setup.py install for functools32 02:59:25 INFO - warning: no files found matching '*.txt' 02:59:25 INFO - no previously-included directories found matching 'build' 02:59:25 INFO - no previously-included directories found matching 'dist' 02:59:25 INFO - no previously-included directories found matching '.git*' 02:59:25 INFO - Successfully installed jsonschema functools32 02:59:25 INFO - Cleaning up... 02:59:26 INFO - Return code: 0 02:59:26 INFO - Installing functools32==3.2.3-2 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', '--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 0x10fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e090>, '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 0x146ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1468f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', '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', '--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:26 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: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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', 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): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:59:26 INFO - Cleaning up... 02:59:26 INFO - Return code: 0 02:59:26 INFO - Installing blobuploader==1.2.4 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', '--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 0x10fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e090>, '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 0x146ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1468f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', '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', '--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:26 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: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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', 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 - Downloading/unpacking blobuploader==1.2.4 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:27 INFO - Downloading blobuploader-1.2.4.tar.gz 02:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:59:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:59:27 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:27 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:27 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:27 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:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:59:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:59:27 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:27 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:27 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:27 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 - Downloading docopt-0.6.1.tar.gz 02:59:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:59:28 INFO - Installing collected packages: blobuploader, requests, docopt 02:59:28 INFO - Running setup.py install for blobuploader 02:59:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:59:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:59:28 INFO - Running setup.py install for requests 02:59:28 INFO - Running setup.py install for docopt 02:59:28 INFO - Successfully installed blobuploader requests docopt 02:59:28 INFO - Cleaning up... 02:59:28 INFO - Return code: 0 02:59:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:28 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 0x10fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e090>, '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 0x146ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1468f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 02:59:28 INFO - 'HOME': '/home/cltbld', 02:59:28 INFO - 'LANG': 'en_US.UTF-8', 02:59:28 INFO - 'LANGUAGE': 'en_US:en', 02:59:28 INFO - 'LOGNAME': 'cltbld', 02:59:28 INFO - 'MAIL': '/var/mail/cltbld', 02:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:28 INFO - 'MOZ_NO_REMOTE': '1', 02:59:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:28 INFO - 'NO_EM_RESTART': '1', 02:59:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:28 INFO - 'PWD': '/builds/slave/test', 02:59:28 INFO - 'SHELL': '/bin/bash', 02:59:28 INFO - 'SHLVL': '1', 02:59:28 INFO - 'TERM': 'linux', 02:59:28 INFO - 'TMOUT': '86400', 02:59:28 INFO - 'USER': 'cltbld', 02:59:28 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', 02:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:28 INFO - '_': '/tools/buildbot/bin/python'} 02:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:28 INFO - Running setup.py (path:/tmp/pip-oaYpzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:29 INFO - Running setup.py (path:/tmp/pip-ikYfrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:29 INFO - Running setup.py (path:/tmp/pip-wbnmxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:29 INFO - Running setup.py (path:/tmp/pip-WQPj_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:29 INFO - Running setup.py (path:/tmp/pip-JbUC0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:29 INFO - Running setup.py (path:/tmp/pip-O8zCEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:29 INFO - Running setup.py (path:/tmp/pip-pZgr1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:29 INFO - Running setup.py (path:/tmp/pip-BABdOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:29 INFO - Running setup.py (path:/tmp/pip-DXVKuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:29 INFO - Running setup.py (path:/tmp/pip-sc82Et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:29 INFO - Running setup.py (path:/tmp/pip-CN4gCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:29 INFO - Running setup.py (path:/tmp/pip-c5zZqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:29 INFO - Running setup.py (path:/tmp/pip-avZtPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:29 INFO - Running setup.py (path:/tmp/pip-tOZlX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:29 INFO - Running setup.py (path:/tmp/pip-j7KtI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:30 INFO - Running setup.py (path:/tmp/pip-_H8WAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:30 INFO - Running setup.py (path:/tmp/pip-tIbeMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:59:30 INFO - Running setup.py install for manifestparser 02:59:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:59:30 INFO - Running setup.py install for mozcrash 02:59:30 INFO - Running setup.py install for mozdebug 02:59:30 INFO - Running setup.py install for mozdevice 02:59:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:59:30 INFO - Running setup.py install for mozfile 02:59:30 INFO - Running setup.py install for mozhttpd 02:59:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:59:30 INFO - Running setup.py install for mozinfo 02:59:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:59:30 INFO - Running setup.py install for mozInstall 02:59:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:59:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:59:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:59:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:59:30 INFO - Running setup.py install for mozleak 02:59:31 INFO - Running setup.py install for mozlog 02:59:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:59:31 INFO - Running setup.py install for moznetwork 02:59:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:59:31 INFO - Running setup.py install for mozprocess 02:59:31 INFO - Running setup.py install for mozprofile 02:59:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:59:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:59:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:59:31 INFO - Running setup.py install for mozrunner 02:59:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:59:31 INFO - Running setup.py install for mozscreenshot 02:59:31 INFO - Running setup.py install for moztest 02:59:31 INFO - Running setup.py install for mozversion 02:59:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:59:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:59:31 INFO - Cleaning up... 02:59:31 INFO - Return code: 0 02:59:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:31 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 0x10fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e090>, '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 0x146ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1468f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', '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:31 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:31 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:31 INFO - Using env: {'DISPLAY': ':0', 02:59:31 INFO - 'HOME': '/home/cltbld', 02:59:31 INFO - 'LANG': 'en_US.UTF-8', 02:59:31 INFO - 'LANGUAGE': 'en_US:en', 02:59:31 INFO - 'LOGNAME': 'cltbld', 02:59:31 INFO - 'MAIL': '/var/mail/cltbld', 02:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:31 INFO - 'MOZ_NO_REMOTE': '1', 02:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:31 INFO - 'NO_EM_RESTART': '1', 02:59:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:31 INFO - 'PWD': '/builds/slave/test', 02:59:31 INFO - 'SHELL': '/bin/bash', 02:59:31 INFO - 'SHLVL': '1', 02:59:31 INFO - 'TERM': 'linux', 02:59:31 INFO - 'TMOUT': '86400', 02:59:31 INFO - 'USER': 'cltbld', 02:59:31 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', 02:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:31 INFO - '_': '/tools/buildbot/bin/python'} 02:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:59:32 INFO - Running setup.py (path:/tmp/pip-ut7k3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:59:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:59:32 INFO - Running setup.py (path:/tmp/pip-hGnLoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:59:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:59:32 INFO - Running setup.py (path:/tmp/pip-WiCSgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:59:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:59:32 INFO - Running setup.py (path:/tmp/pip-Xy8tdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:59:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:59:32 INFO - Running setup.py (path:/tmp/pip-srkCHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:59:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:59:32 INFO - Running setup.py (path:/tmp/pip-3Qsahy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:59:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:59:32 INFO - Running setup.py (path:/tmp/pip-1deMKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:59:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:59:32 INFO - Running setup.py (path:/tmp/pip-JPEWQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:59:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:59:32 INFO - Running setup.py (path:/tmp/pip-Hy8KiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:59:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:59:32 INFO - Running setup.py (path:/tmp/pip-c1VFW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:59:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:59:32 INFO - Running setup.py (path:/tmp/pip-fEpdnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:59:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:59:32 INFO - Running setup.py (path:/tmp/pip-3b6Aky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:59:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:59:33 INFO - Running setup.py (path:/tmp/pip-X41NwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:59:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:59:33 INFO - Running setup.py (path:/tmp/pip-a_vuAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:59:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:33 INFO - Running setup.py (path:/tmp/pip-w1VhlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:59:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:59:33 INFO - Running setup.py (path:/tmp/pip-xgik3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:59:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:59:33 INFO - Running setup.py (path:/tmp/pip-osCmgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:59:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:59:33 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:33 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:33 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:33 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:34 INFO - Downloading blessings-1.6.tar.gz 02:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:59:34 INFO - Installing collected packages: blessings 02:59:34 INFO - Running setup.py install for blessings 02:59:34 INFO - Successfully installed blessings 02:59:34 INFO - Cleaning up... 02:59:34 INFO - Return code: 0 02:59:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:59:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:34 INFO - Reading from file tmpfile_stdout 02:59:34 INFO - Current package versions: 02:59:34 INFO - argparse == 1.2.1 02:59:34 INFO - blessings == 1.6 02:59:34 INFO - blobuploader == 1.2.4 02:59:34 INFO - docopt == 0.6.1 02:59:34 INFO - functools32 == 3.2.3-2 02:59:34 INFO - jsonschema == 2.5.1 02:59:34 INFO - manifestparser == 1.1 02:59:34 INFO - mozInstall == 1.13 02:59:34 INFO - mozcrash == 1.0 02:59:34 INFO - mozdebug == 0.1 02:59:34 INFO - mozdevice == 0.51 02:59:34 INFO - mozfile == 1.2 02:59:34 INFO - mozhttpd == 0.7 02:59:34 INFO - mozinfo == 0.10 02:59:34 INFO - mozleak == 0.1 02:59:34 INFO - mozlog == 3.5 02:59:34 INFO - moznetwork == 0.27 02:59:34 INFO - mozprocess == 0.25 02:59:34 INFO - mozprofile == 0.28 02:59:34 INFO - mozrunner == 6.13 02:59:34 INFO - mozscreenshot == 0.1 02:59:34 INFO - mozsystemmonitor == 0.3 02:59:34 INFO - moztest == 0.8 02:59:34 INFO - mozversion == 1.4 02:59:34 INFO - psutil == 3.1.1 02:59:34 INFO - requests == 1.2.3 02:59:34 INFO - wsgiref == 0.1.2 02:59:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:59:34 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:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:34 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:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:34 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 0x10fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e090>, '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 0x146ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1468f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 02:59:35 INFO - 'HOME': '/home/cltbld', 02:59:35 INFO - 'LANG': 'en_US.UTF-8', 02:59:35 INFO - 'LANGUAGE': 'en_US:en', 02:59:35 INFO - 'LOGNAME': 'cltbld', 02:59:35 INFO - 'MAIL': '/var/mail/cltbld', 02:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:35 INFO - 'MOZ_NO_REMOTE': '1', 02:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:35 INFO - 'NO_EM_RESTART': '1', 02:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:35 INFO - 'PWD': '/builds/slave/test', 02:59:35 INFO - 'SHELL': '/bin/bash', 02:59:35 INFO - 'SHLVL': '1', 02:59:35 INFO - 'TERM': 'linux', 02:59:35 INFO - 'TMOUT': '86400', 02:59:35 INFO - 'USER': 'cltbld', 02:59:35 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', 02:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:35 INFO - '_': '/tools/buildbot/bin/python'} 02:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 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:35 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:59:35 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:35 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:35 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:35 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:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:59:36 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:36 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:36 INFO - Installing collected packages: simplejson 02:59:36 INFO - Running setup.py install for simplejson 02:59:36 INFO - building 'simplejson._speedups' extension 02:59:36 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:37 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:37 INFO - Successfully installed simplejson 02:59:37 INFO - Cleaning up... 02:59:37 INFO - Return code: 0 02:59:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:59:37 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:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:37 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:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:37 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 0x10fe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146aa60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146e090>, '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 0x146ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1468f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 02:59:37 INFO - 'HOME': '/home/cltbld', 02:59:37 INFO - 'LANG': 'en_US.UTF-8', 02:59:37 INFO - 'LANGUAGE': 'en_US:en', 02:59:37 INFO - 'LOGNAME': 'cltbld', 02:59:37 INFO - 'MAIL': '/var/mail/cltbld', 02:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:37 INFO - 'MOZ_NO_REMOTE': '1', 02:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:37 INFO - 'NO_EM_RESTART': '1', 02:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:37 INFO - 'PWD': '/builds/slave/test', 02:59:37 INFO - 'SHELL': '/bin/bash', 02:59:37 INFO - 'SHLVL': '1', 02:59:37 INFO - 'TERM': 'linux', 02:59:37 INFO - 'TMOUT': '86400', 02:59:37 INFO - 'USER': 'cltbld', 02:59:37 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', 02:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:37 INFO - '_': '/tools/buildbot/bin/python'} 02:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:59:37 INFO - Cleaning up... 02:59:37 INFO - Return code: 0 02:59:37 INFO - Running post-action listener: _resource_record_post_action 02:59:37 INFO - Running post-action listener: _start_resource_monitoring 02:59:37 INFO - Starting resource monitoring. 02:59:37 INFO - [mozharness: 2017-09-15 09:59:37.708977Z] Finished create-virtualenv step (success) 02:59:37 INFO - [mozharness: 2017-09-15 09:59:37.709921Z] Running install step. 02:59:37 INFO - Running pre-action listener: _resource_record_pre_action 02:59:37 INFO - Running main action method: install 02:59:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:59:37 INFO - Reading from file tmpfile_stdout 02:59:37 INFO - Detecting whether we're running mozinstall >=1.0... 02:59:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:59:38 INFO - Reading from file tmpfile_stdout 02:59:38 INFO - Output received: 02:59:38 INFO - Usage: mozinstall [options] installer 02:59:38 INFO - Options: 02:59:38 INFO - -h, --help show this help message and exit 02:59:38 INFO - -d DEST, --destination=DEST 02:59:38 INFO - Directory to install application into. [default: 02:59:38 INFO - "/builds/slave/test"] 02:59:38 INFO - --app=APP Application being installed. [default: firefox] 02:59:38 INFO - mkdir: /builds/slave/test/build/application 02:59:38 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:38 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:55 INFO - Reading from file tmpfile_stdout 02:59:55 INFO - Output received: 02:59:55 INFO - /builds/slave/test/build/application/firefox/firefox 02:59:55 INFO - Running post-action listener: _resource_record_post_action 02:59:55 INFO - [mozharness: 2017-09-15 09:59:55.855700Z] Finished install step (success) 02:59:55 INFO - [mozharness: 2017-09-15 09:59:55.855949Z] Running setup-mitmproxy step. 02:59:55 INFO - Running pre-action listener: _resource_record_pre_action 02:59:55 INFO - Running main action method: setup_mitmproxy 02:59:55 INFO - Skipping: mitmproxy is not required 02:59:55 INFO - Running post-action listener: _resource_record_post_action 02:59:55 INFO - [mozharness: 2017-09-15 09:59:55.857074Z] Finished setup-mitmproxy step (success) 02:59:55 INFO - [mozharness: 2017-09-15 09:59:55.857292Z] Running run-tests step. 02:59:55 INFO - Running pre-action listener: _resource_record_pre_action 02:59:55 INFO - Running pre-action listener: _set_gcov_prefix 02:59:55 INFO - Running main action method: run_tests 02:59:55 WARNING - Try message not found. 02:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:59:55 INFO - Python 2.7.3 02:59:55 INFO - Return code: 0 02:59:55 INFO - grabbing minidump binary from tooltool 02:59:55 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:55 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 0x146e090>, '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 0x146ed80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1468f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:59:55 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:55 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:55 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:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:59:56 INFO - Return code: 0 02:59:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:59:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:59:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:59:56 INFO - ENV: RUST_BACKTRACE is now full 02:59:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:59:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:59:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 02:59:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 02:59:56 INFO - Using env: {'DISPLAY': ':0', 02:59:56 INFO - 'HOME': '/home/cltbld', 02:59:56 INFO - 'LANG': 'en_US.UTF-8', 02:59:56 INFO - 'LANGUAGE': 'en_US:en', 02:59:56 INFO - 'LOGNAME': 'cltbld', 02:59:56 INFO - 'MAIL': '/var/mail/cltbld', 02:59:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:59:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:59:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:56 INFO - 'MOZ_NO_REMOTE': '1', 02:59:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:59:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:59:56 INFO - 'NO_EM_RESTART': '1', 02:59:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:59:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:56 INFO - 'PWD': '/builds/slave/test', 02:59:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:59:56 INFO - 'RUST_BACKTRACE': 'full', 02:59:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:59:56 INFO - 'SHELL': '/bin/bash', 02:59:56 INFO - 'SHLVL': '1', 02:59:56 INFO - 'TERM': 'linux', 02:59:56 INFO - 'TMOUT': '86400', 02:59:56 INFO - 'USER': 'cltbld', 02:59:56 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', 02:59:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:56 INFO - '_': '/tools/buildbot/bin/python'} 02:59:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 02:59:56 INFO - mozversion application_buildid: 20170915090610 02:59:56 INFO - mozversion application_changeset: 893fe1549e1e7342a66514b65960f08d40810a34 02:59:56 INFO - mozversion application_display_name: Nightly 02:59:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:59:56 INFO - mozversion application_name: Firefox 02:59:56 INFO - mozversion application_remotingname: firefox 02:59:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:59:56 INFO - mozversion application_vendor: Mozilla 02:59:56 INFO - mozversion application_version: 57.0a1 02:59:56 INFO - mozversion platform_buildid: 20170915090610 02:59:56 INFO - mozversion platform_changeset: 893fe1549e1e7342a66514b65960f08d40810a34 02:59:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:59:56 INFO - mozversion platform_version: 57.0a1 02:59:56 INFO - using testdate: 1505469596 02:59:56 INFO - actual date: 1505469596 02:59:56 INFO - starting webserver on 'localhost:54079' 02:59:56 INFO - SUITE-START | Running 2 tests 02:59:56 INFO - TEST-START | dromaeo_css 02:59:56 INFO - Initialising browser for dromaeo_css test... 02:59:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54079/getInfo.html -profile /tmp/tmpI4nPXq/profile 02:59:56 INFO - TEST-INFO | started process 3518 (/builds/slave/test/build/application/firefox/firefox http://localhost:54079/getInfo.html) 03:00:04 INFO - TEST-INFO | 3518: exit 0 03:00:04 INFO - Browser initialized. 03:00:04 INFO - Running cycle 1/1 for dromaeo_css test... 03:00:04 INFO - Using env: {'DISPLAY': ':0', 03:00:04 INFO - 'HOME': '/home/cltbld', 03:00:04 INFO - 'JSGC_DISABLE_POISONING': '1', 03:00:04 INFO - 'LANG': 'en_US.UTF-8', 03:00:04 INFO - 'LANGUAGE': 'en_US:en', 03:00:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:00:04 INFO - 'LOGNAME': 'cltbld', 03:00:04 INFO - 'MAIL': '/var/mail/cltbld', 03:00:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:00:04 INFO - 'MOZ_CRASHREPORTER': '1', 03:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:00:04 INFO - 'MOZ_NO_REMOTE': '1', 03:00:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:04 INFO - 'NO_EM_RESTART': '1', 03:00:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:04 INFO - 'PWD': '/builds/slave/test', 03:00:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:04 INFO - 'RUST_BACKTRACE': 'full', 03:00:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:00:04 INFO - 'SHELL': '/bin/bash', 03:00:04 INFO - 'SHLVL': '1', 03:00:04 INFO - 'STYLO_FORCE_DISABLED': '1', 03:00:04 INFO - 'TERM': 'linux', 03:00:04 INFO - 'TMOUT': '86400', 03:00:04 INFO - 'USER': 'cltbld', 03:00:04 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', 03:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:04 INFO - '_': '/tools/buildbot/bin/python'} 03:00:04 INFO - TEST-INFO | started process 3751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI4nPXq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:05 INFO - PID 3751 | 03:00:05 INFO - PID 3751 | (/builds/slave/test/build/application/firefox/firefox:3800): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:00:05 INFO - PID 3751 | 03:00:15 INFO - PID 3751 | RSS: Main: 173416448 03:00:15 INFO - PID 3751 | 03:03:13 INFO - PID 3751 | Cycle 1(1): loaded http://localhost:54079/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54079/tests/dromaeo/cssquery-ext.html) 03:03:14 INFO - PID 3751 | RSS: Main: 175923200 03:03:14 INFO - PID 3751 | 03:06:16 INFO - PID 3751 | Cycle 1(1): loaded http://localhost:54079/tests/dromaeo/cssquery-ext.html (next: http://localhost:54079/tests/dromaeo/cssquery-jquery.html) 03:06:16 INFO - PID 3751 | RSS: Main: 170799104 03:06:16 INFO - PID 3751 | 03:09:18 INFO - PID 3751 | Cycle 1(1): loaded http://localhost:54079/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54079/tests/dromaeo/cssquery-mootools.html) 03:09:19 INFO - PID 3751 | RSS: Main: 175177728 03:09:19 INFO - PID 3751 | 03:12:20 INFO - PID 3751 | Cycle 1(1): loaded http://localhost:54079/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54079/tests/dromaeo/cssquery-prototype.html) 03:12:21 INFO - PID 3751 | RSS: Main: 173187072 03:12:21 INFO - PID 3751 | 03:15:24 INFO - PID 3751 | Cycle 1(1): loaded http://localhost:54079/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54079/tests/dromaeo/cssquery-yui.html) 03:15:25 INFO - PID 3751 | RSS: Main: 175140864 03:15:25 INFO - PID 3751 | 03:18:26 INFO - PID 3751 | Cycle 1(1): loaded http://localhost:54079/tests/dromaeo/cssquery-yui.html (next: http://localhost:54079/tests/dromaeo/cssquery-dojo.html) 03:18:27 INFO - PID 3751 | RSS: Main: 178081792 03:18:27 INFO - PID 3751 | 03:18:27 INFO - PID 3751 | __start_tp_report 03:18:27 INFO - PID 3751 | _x_x_mozilla_page_load 03:18:27 INFO - PID 3751 | _x_x_mozilla_page_load_details 03:18:27 INFO - PID 3751 | |i|pagename|runs| 03:18:27 INFO - PID 3751 | |0;dojo.html;3163.1301392117166;3163.8101713897167;3169.223540232642;3183.570218020568;3219.1308346746364;6219.689015549227;6322.241331040276;6416.518761092913;6436.613803171813;6461.547691661585;6303.275123360815;6312.6212427254395;6342.524310676695;6349.42855143037;6473.838154046151;5833.649981001132;5872.530197584194;5928.49607783339;5931.495822855041;5954.345022047572;5681.687507187103;5847.386024467433;5870.148828419877;5889.499392551638;5965.850853728648;5817.7091145442555;5914.585978981473;5915.408459154093;5964.3737407572235;5983.970080149615;5702.030654788696;5800.361960184377;5816.941830581683;5865.325487568942;5876.764929402819;5819.9418005819825;5835.824925252249;5837.270341207349;5856.736446859902;5870.618409803349;6287.402696743802;6418.711157997901;6425.710843012076;6443.162388889415;6489.70796314167;6834.043233947252;6836.863262734767;6865.622390768505;6937.791866244021;6940.063091482636;6710.42961348286;6854.0404343391965;6857.382835544825;6862.759803406907;6864.24493305736;6287.308396076428;6297.464715499188;6317.368263173692;6395.552311338208;6428.485721142298;6998.545094568837;7008.299170083053;7112.822179445555;7118.60847653384;7126.501144919909;6697.464202863759;6726.8654626908165;6749.763758268437;6800.557963732342;6829.6243706596615;6736;6805.115335006517;6819.24988251292;6902.068220790129;6956.200036995709;6757.155355580552;6757.898631520531;6839.931600684029;6844.93155068443;6880.793576192722;6823.69293381799;6919.481038922101;6922.8615427692175;6931.930680693229;6933.37599616037;5360.839174824761;5361.329833770778;5402.054640437907;5410;5412.702301373383;4575.725456472623;4656.41794775653;4673.626109911199;4682.180618391768;4691.648126390534;5881.823545293648;5890.676012819336;5892.440218179266;5895.380984996599;5928.466438020512;6872.484563657746;6879.3120687930805;6950.965245173742;6956.513044086865;6971.82570435733;5854.121881717691;5858.238429004202;5922.170896074467;5937.960856850034;5942.257217847769;5714.200011998323;5783.942160578425;5872.970635146882;5936.881262374728;5951.940480595139;6513.869722605521;6540.313267106981;6561.311062338481;6569.901451478136;6577.80266592003;6805.081314022544;6881.41507971828;6918.896216556856;6921.169459664872;6952.652367381712;6546.410823025951;6572.704228309642;6632.90050649231;6673.265940746611;6700.4639628830555;6763.12079429671;6789.456843452611;6848.9657551711925;6870.587764734132;6877.071595334566;6673.9666301668185;6800.761973330909;6813.216480104653;6813.454923606;6903.792886213421;6649.534532582673;6701.229358623626;6701.731930722716;6703.396694297537;6718.395344419026;6670.733170673118;6730.932690673227;6731.730730770714;6736.427403670743;6745.730170793114;6595.076689263411;6595.142631457879;6673.9666301668185;6683.665816709048;6695.230048544479;6580.243272023778;6604.801855944329;6701.128853249046;6733.595984240961;6746.35909588608;6303.306636269915;6442.35576442352;6497.94835497166;6592.67036648156;6603.834904127243 03:18:27 INFO - PID 3751 | |1;ext.html;849.5837039850472;882.2456799436482;888.2893685051956;888.3204348673266;895.046775184429;40693;41383.58616413835;41708.79145604268;41719.37420938684;41736;37397.43903841444;37455.25089498215;37516.24967500648;37864.62135378645;37913.431298530544;6991.300869913019;7089.078419805418;7131.714731410737;7134.357907788298;7153.964230178868;7033.296670332977;7120.4659650526155;7131.108611423572;7134.072570565819;7137.643117844113;7702.537847729154;7985.241402066823;7994.880076798852;7996.640151193181;7996.720114795983;7892.644830982591;7915.762527124196;7964.8805267921025;7965.681372745054;7968.721094761713;7529.510581812219;7737.9226207737765;7745.690172393098;7753.96123019387;7754.883676744853;36817.26365472702;37203;37219;37239;37288.44067338992;3515.894523164284;3555.7510974231814;3576.624454432273;3596.892093237207;3596.9100772480638;30603.846980764953;30648.387032259452;30688.386232275454;30701.539476907863;30720.53919191214;5151.484851514856;5180.352455943007;5192;5197.090509160919;5238.319018527567;182152.08923955297;183415;183886;185030.07484962622;185282;38384.80807596;38877.22245555073;39126.41310380347;48005.279920801215;48964.26553601699;51614.74192629088;51759.74120129375;51795.482045179066;51844;51969.48030519646;16239.944403613727;16388.672226555642;16418.6716265674;16459.83540164607;16500.092494912897;13401.93299033518;13503.257320847448;13511.05422620407;13527.188368697909;13539.526116586068;14270.785938210935;14293.78559321611;14355.138691678532;14404.20776857262;14631.780523292158;5706.201131841545;5721.713914304268;5725.5133313667975;5802.6808525531505;5930;991.4299277915228;995.9253056020827;1002.3785253143097;1026.6150193677372;1032.0762917189074;22966.770332296463;23060.769392306196;23063.19278825233;23120.884395577916;23258;1101.2236373356764;1102.8456016157745;1106.4799544214206;1124.4490199802037;1125.1617544929081;12065.336406497552;12082.758344833053;12199.390030498616;12311.19977201497;12315.93842030802;215249;215560;216023;216953;217479;53623;53858.461415386126;53882.46117538775;53999.46000539944;54074.188887166725;1420.5241244183107;1468.8971771976073;1469.7427950108688;1471.1687896338535;1476.3946781819618;21821.78178218261;22122.889385552968;22125.225617103326;22396;22613;37556;37558.248835023696;37665.62334376621;37667.623323767504;37739.62260377471;178796;179021;179992;180303;181507;34138.14654633555;35689.64310356863;36095.81952090223;36137.63862361343;36206.818965905004;45225.773871130434;46375.304370435144;46956;46994.53005469902;47683.76158119187;33558.66441335555;33740.156496087795;33876.15309617279;34025.82987085049;34164;33658.32683346368;34202;34357.82821085879;34372;34708;37666.24667506689;37768;38022.42966355452;38345.041373965876;38395.6160438392;32966.175845604055;33398;33413.49879751854;33450;34223.657763422045;24760;24892.128775492773;24977.625335620345;25042.62436063424;25108.12121575736 03:18:27 INFO - PID 3751 | |2;jquery.html;478.78215411987543;544.8801263721982;554.2960440240892;563.6927874308501;577.725580349334;21970.231041913536;22576.43558911028;22640.320790376296;22654.66018009731;22674.88662556689;23933.5213295734;24058.157964471247;24425.389365265877;24430.267091987225;25303.493930121385;6471.805845824621;6603.240627327871;6651.634160121192;6651.634160121192;6654.234763002244;6170.660613666247;6444.935550644504;6527.967360163192;6529.836754081162;6536.967315163418;6306.527010474209;6321.46267567255;6354.7775827846035;6355;6355.777547785829;6329.588576742543;6341.682915854212;6353.0788035734795;6364.809055728336;6402.103705481236;6121.204243448323;6142.84642883927;6156.045812899008;6157.107219453199;6164.321924588292;28550.286242843886;29107.272318192005;29169.124926252036;29192.8540357299;29198.416031679248;2044.1721102953327;2068.5449201175716;2072.1814883121083;2079.854410191287;2087.6033553624916;17993.64012719738;18482.2607095716;18808.62382752351;18917.14872830726;19052.90473547637;2428.477877256398;2434.2514899042367;2453.1291391556097;2494.301595553248;2507.348089496744;114910;120590.3970480142;122915;123731;133767;14538.689519021938;14718.190499522629;14719.207196767395;14883.776743348642;14948.252587370805;22198.445038874157;22290.88854555717;22293.66559501609;22305.888470557544;22330.441738956655;10221.795564088676;10289.485525723683;10295.330803497749;10429.895701043044;10580.523876425425;9648.179904708179;9652.876367199206;9656.565454554562;9718.757031074138;9782.608695652236;8866.645334186689;8922.687705930392;9067.637294508146;9113.689465005416;9130.269578433843;2742.561190209557;2758.875850586688;2759.7378249066305;2779.416322572242;2866.054202113298;941.4915945389413;954.2509130332655;962.711186644004;968.1045033344128;968.4479846487575;18834.15246313892;19205.519862003282;19373.612527749367;19639.410817675493;19839.30562430308;995.7809281957958;1002.644061358222;1003.8092762375126;1003.82934901067;1008.2488546033252;10715.571377144983;10800.567977280978;10834.891651083388;10967.941552219758;11063.612773553048;449022.01955960697;456887;462719;465139;472772;106678;107588;109787;110281;112564.43717781358;1035.9326643768131;1078;1092.1535809747509;1124.9043831274269;1127.0926903842485;20536.38390848277;20632.793672063086;20665.793342066387;20940.790592093883;20972.26597069095;55304.17043744428;56038;56762.14856777069;56773.432265678464;57341.71329143494;68231.65884170547;69245.65377173283;69663;69804;69823;14179.078359906573;14412.279386030867;14513.709725805636;14536.927315363355;14606.269686515845;23218.767812322338;23476;23622.29133126009;23640;23751.693656848347;18505.72241416353;18552.81447185511;18765.155567999198;18871.433856983764;18875;16539.75190372121;16831.495055148363;17141.400050998156;17175.31298748036;17285.827141728925;18326.17532211027;18657.507399408285;18986.240550377832;19229.8077019228;19258.22967081301;14216.431342746175;14302.213378264296;14375.496857609933;14409.279536023367;14496.710065798414;18393.908030459763;18476.353327633467;18484;18532.907335463235;18657.346992855186 03:18:27 INFO - PID 3751 | |3;mootools.html;1319.3930791835755;1382.5092092307232;1389.4442223110748;1399.0626280392132;1414.483713444593;15130.092194468325;15820.683586328267;15826.683466330667;15832.604184895383;15850.445234416784;15594.688106237896;15627.843721562782;15711.292991815368;15722.213889305518;15728.292226849791;2719.2250208690575;2734.1524127520433;2787.6236708044357;2791.4696207720467;2793.0503628766214;2606.5162907268113;2651.9071832485865;2653.4825708986755;2659.9335016624545;2665.4269332093595;2655.137080448852;2767.764739997103;2858.757005654522;2868.4263147370507;2870.9569356459565;2689.8789554470095;2740.753332200102;2752.270648278208;2768.2664094015004;2769.4322663853864;2731.9180424587294;2739.2740923655247;2749.8625068746683;2752.779777617806;2755.3938133610573;14836.480723174745;15152.090874547563;15179.620509487351;15192.772108418383;15219.315130819139;8056.758297251092;8355.03917049541;8372.079071302152;8372.28835548979;8386.203310685476;5595.7481913313995;5773.971130144364;5819.53443724501;5881.67650779207;5895.911561326584;1875.8217969292896;1883.8398736107447;1900.8669393142486;1938.1569017477302;1945.2413558712115;26874.86562567194;27116.59325110125;27130.864345678146;27148;27152.456950860873;7450.813729656802;7464.365528929993;7689.077310722749;7696.7306144284685;7736.574488403192;17071.914640426967;17184;17212.569685757957;17232.138393080546;17233.482995510156;7976.162502937108;8102.716404925799;8146.837063258702;8172.754817355489;8186.2632363087605;7460.365868901095;7538.283863033003;7566.810829729191;7580.431467639949;7607.809804754926;4868.440129385166;5026.346574945233;5054.444011158769;5101.387833460009;5109.846704598868;1427.7644188708746;1481.0595272002356;1495.6634757179547;1497.7828214908777;1518.5899807052035;729.8175456135966;880.9735707928772;891.1044400377579;896.9461832290084;906.2478143141177;8564.14358564151;8611;8629.266512346521;8676.045634980148;8681.869771953427;965.5510187762724;965.6716716316486;969.5892476446753;971.3006635222629;978.256525040974;5184.7407629618365;5475.917861232085;5492.368377636623;5568.554515638739;5583.274174357389;20802;20974.685379719318;21263.574728505344;21856.453588660093;21898.01458934352;20359.389218323475;21420.357389278346;21531;21679.132834686752;21771.67342489864;11164.553417863357;11612.535498580131;11642;11710.648680539427;11722.355270460206;7897.289243968071;8166.877496837671;8264.338852891875;8269.751907442786;8328.167183281623;18123.184456699742;18583.070846457893;18698.158582864075;19161.041947902828;19325;18626.254949801856;18647.254109835998;18722.906385467984;18752.718709219647;18807.90596047011;10599.576016959236;10819.891801081889;10828;10905.073068789241;10926.6721998337;13580.45678172862;13691.931540342235;13702.177869327872;13743.244121573409;13820;10987.945060274968;11108.277961932772;11405.429728513707;11427.257228280136;11466.967972882481;10867.673969780602;11011.119110471303;11102.167337449562;11256.493457794255;11375.829362559403;10052.145567626834;10059.195264378686;10142.137918277029;10218.540165692413;10240.846387304346;7567.545947243183;7570.280823321996;7586.089669239726;7642.770716878503;7737.14891361961;7415.184329723834;7488.101427828696;7491.73778917757;7495.36289415384;7554.508956917783 03:18:27 INFO - PID 3751 | |4;prototype.html;486.31186870578136;525.5270256768908;528.8704267454474;529.52078369076;530.1385248970423;6348.079528468375;6360.713767880445;6373.521985851056;6382.712777924993;6477.157969463969;6266.404691554295;6281.937180628192;6341.207349081365;6354.586951848127;6356.491480681546;5180;5195.9480405195845;5222.216667499877;5253.553447956909;5279.762410691509;5220.895582088375;5220.981908527839;5224.582033437335;5230.607704422165;5243.370795504526;4867.415910090794;4973.880876802708;5010.498950104997;5015.874603134933;5054.862655902411;5032.672876263049;5054.69671819692;5056.140456122431;5068.08774420606;5077.593792496591;4492.483364413101;4493.640508759291;4493.932591011137;4505;4505.662075344362;6066.695660433028;6227.844303892393;6230.5638605297645;6245.125682404467;6253.812385628438;5736.971315143439;5741.45456181662;5747.453991870766;5756.395578464285;5795.797147099831;6528.77149299777;6590;6611.239707433659;6659.467242620579;6679.76620818269;4875.804967801284;4928.26076088586;4936.358273424432;4937.703737775745;4981.9252711209365;6635.535512514126;6802;6856.862862742767;6988.685509152049;7017.2631873653045;5025.120603894304;5048.8232911848645;5082.932584157368;5093.337866077386;5103.7192954387865;5128.282040514331;5155.097857874932;5160.251763494272;5161.174212126042;5188.403333616607;5615.775368985276;5673.886522269531;5698.943010569924;5733.598648094593;5784.305883294031;6663.133792607027;6703.3296670332575;6711.832204194837;6713.899291510631;6716.731330746813;1755.824417558234;1763.9294428222984;1778.4575704410279;1782.4919897829056;1795.2370242646823;1160.3328086350382;1192.451472322724;1220.523166967961;1224.3878060969516;1228.8218208359738;5791.0734282514595;5808.128780682847;5812.418758124154;5878.676672782953;5886.470217680429;6709.329067093252;6811.318868113149;6853.760118395832;6880.869204511935;6923.515353925278;5727.365411910485;5750.482456578928;5792.391798861143;5807.651540907559;5824.475797178275;3574.5889222739197;3595.957172419969;3614.8915532534065;3620.420732682811;3663.413853783382;6549.476041916635;6556.164274003287;6567.474602031826;6601.174853143357;6606.372394622503;6867.484938629623;6918.377346038881;6961.26906674802;6983.755568555076;7034.19106802714;6133.560938281793;6441.838954026187;6447.09810605863;6509.641969691617;6576.934230657728;6550.213974323112;6701.430378417889;6718.697658605277;6722.63868065967;6758.2565917748025;6523.31505191967;6528.543001990005;6587.912994355877;6598.931496853986;6616.4045235929;6309.842253943688;6323.936760632335;6479;6551.344865513411;6624.735010599522;5051.772670229922;5055.848324550122;5057.241413787961;5061.291419201241;5080.517350851663;6591.176102987127;6681.095887671991;6789.947558128498;6911.723531058701;6924.653767311514;6413.518986076157;6534.901976470452;6550.672466376757;6596.769113081019;6653.866922661617;6422.719934423212;6436.16329877113;6466.482681385572;6533.477321814338;6554.311797261219;6277.560570760185;6367.267764207176;6376.585521941059;6439.710213040518;6495.220573531206;6582.473402127914;6598.307177746459;6621.377762448231;6625.17185351831;6632.734690612321;6291.874162516816;6304.464120549805;6335.65153916539;6361.459275961595;6361.522885783492 03:18:27 INFO - PID 3751 | |5;yui.html;896.6816780043089;917.3945196170527;936.4240991790051;938.3478482454697;951.900050494698;16465.176741162937;16540.255688494017;16561;16703.83296167038;16715.83284167158;15740.055596664179;15797.526074217792;15980.360785568593;16042;17203.139843007863;930.9767255818608;940.7177846646013;943.2972435535536;943.32552225159;943.9858402123974;951.0584521323909;958;958.8274110660078;959.4770849886794;960.4477425480342;937.3579098317674;964.9228061755077;970.5001924009141;973.0852998181722;1002.1932344462705;970.3207754571793;979.8236317462854;980.4313498171043;981.4356744871692;981.8674478945358;703.8908969109796;718.3893690363202;718.622723070387;719.230423446912;725.3979197266257;17455.563610909703;17619.559511012198;17637.64724705499;17646.558836029075;17650.470485885315;21795.67306490404;22289;22455.214067507557;22787.658185127235;22962.885185573967;17112.657746844994;17357.47927562175;17483.475495735147;17530.91234543819;17584.208710608054;3697.8335974880924;3767.416050512175;3774.8490060397826;3777.9055523611855;3778.395456726938;136350;139062;141458;141639;143059.99999999895;16079.598010049609;16491.17544122789;16594.58513537147;16738.916305418395;16748.41380551675;30718;31644.841775791436;31645.683543164734;31816.204594885312;32089.35821283608;7504.737334193277;7509.399248060142;7570.962145189239;7597.962010189914;7629.8855517167285;3770.7171962102952;3859.96140038596;3868.825902834379;3870.7484013539593;3873.4383514390256;5481.725913704299;5575.637583557056;5634.352049514277;5647.548196144381;5660.29246344207;997.3716558568055;1019.4800651667703;1032.6282538286212;1044.0186224948525;1044.3420644993605;667.3393340592778;693.8889777635554;697.6058526932267;704.7040243097911;713.6396119959387;11958;12196.146269761031;12236.571719989757;12606.747865042831;13014.609561713163;696.4567637242959;703.7853454696265;704.1163340008256;720.935115839577;721.6932803558467;5653.95401850659;5662.235598194274;5676.545876329884;5758.280214973129;5761.107028410603;123426;124255;127035;129788.5105744709;129813;112314;113815.43092284485;113995;114906.42546787212;118581;96900;100557;100952;101471.49264253631;101742.49128754309;10402.531886064993;10604.098651614699;10681.57273709043;10829.729256768644;10860.619878304222;43765.34351984659;44105.338419923086;44890.10219795651;45543.54456455393;45902.54097459116;54985.450145498035;56018.71480374849;57166.7141664289;57287.427125729875;58966;15917.522474325326;16121;16148.838511614733;16294.42969496062;16453.58866028311;18243.726344104583;18366.449006529827;18457.16942737607;18475.815241847948;18516.629667406847;15142.924285378944;15258.847411525743;15359.385624574892;15454.227288635298;15494.922525387301;16352.427665031666;16628.75056874172;16717.080560569284;16739.163041848104;16933.238004290084;15899.682006360039;15912.602184945006;16066.598335041717;16250.593735156715;16458.75311870347;11758.235714678518;11846.703832404259;12060.51757929673;12165.939170304091;12230.755384892074;11949.940250298692;12042.75914481723;12044.51821927113;12618.747625047632;12622.495100195889 03:18:27 INFO - PID 3751 | __end_tp_report 03:18:27 INFO - PID 3751 | __start_cc_report 03:18:27 INFO - PID 3751 | _x_x_mozilla_cycle_collect,374 03:18:27 INFO - PID 3751 | __end_cc_report 03:18:27 INFO - PID 3751 | __startTimestamp1505470707020__endTimestamp 03:18:27 INFO - PID 3751 | 03:18:27 INFO - PID 3751 | ------- Summary: start ------- 03:18:27 INFO - PID 3751 | Number of tests: 6 03:18:27 INFO - PID 3751 | 03:18:27 INFO - PID 3751 | [#0] dojo.html Cycles:165 Average:6292.89 Median:6569.90 stddev:767.20 (11.7%) stddev-sans-first:729.21 03:18:27 INFO - PID 3751 | Values: 3163.1 3163.8 3169.2 3183.6 3219.1 6219.7 6322.2 6416.5 6436.6 6461.5 6303.3 6312.6 6342.5 6349.4 6473.8 5833.6 5872.5 5928.5 5931.5 5954.3 5681.7 5847.4 5870.1 5889.5 5965.9 5817.7 5914.6 5915.4 5964.4 5984.0 5702.0 5800.4 5816.9 5865.3 5876.8 5819.9 5835.8 5837.3 5856.7 5870.6 6287.4 6418.7 6425.7 6443.2 6489.7 6834.0 6836.9 6865.6 6937.8 6940.1 6710.4 6854.0 6857.4 6862.8 6864.2 6287.3 6297.5 6317.4 6395.6 6428.5 6998.5 7008.3 7112.8 7118.6 7126.5 6697.5 6726.9 6749.8 6800.6 6829.6 6736.0 6805.1 6819.2 6902.1 6956.2 6757.2 6757.9 6839.9 6844.9 6880.8 6823.7 6919.5 6922.9 6931.9 6933.4 5360.8 5361.3 5402.1 5410.0 5412.7 4575.7 4656.4 4673.6 4682.2 4691.6 5881.8 5890.7 5892.4 5895.4 5928.5 6872.5 6879.3 6951.0 6956.5 6971.8 5854.1 5858.2 5922.2 5938.0 5942.3 5714.2 5783.9 5873.0 5936.9 5951.9 6513.9 6540.3 6561.3 6569.9 6577.8 6805.1 6881.4 6918.9 6921.2 6952.7 6546.4 6572.7 6632.9 6673.3 6700.5 6763.1 6789.5 6849.0 6870.6 6877.1 6674.0 6800.8 6813.2 6813.5 6903.8 6649.5 6701.2 6701.7 6703.4 6718.4 6670.7 6730.9 6731.7 6736.4 6745.7 6595.1 6595.1 6674.0 6683.7 6695.2 6580.2 6604.8 6701.1 6733.6 6746.4 6303.3 6442.4 6497.9 6592.7 6603.8 03:18:27 INFO - PID 3751 | 03:18:27 INFO - PID 3751 | [#1] ext.html Cycles:180 Average:36625.92 Median:36116.73 stddev:50181.03 (138.9%) stddev-sans-first:50249.89 03:18:27 INFO - PID 3751 | Values: 849.6 882.2 888.3 888.3 895.0 40693.0 41383.6 41708.8 41719.4 41736.0 37397.4 37455.3 37516.2 37864.6 37913.4 6991.3 7089.1 7131.7 7134.4 7154.0 7033.3 7120.5 7131.1 7134.1 7137.6 7702.5 7985.2 7994.9 7996.6 7996.7 7892.6 7915.8 7964.9 7965.7 7968.7 7529.5 7737.9 7745.7 7754.0 7754.9 36817.3 37203.0 37219.0 37239.0 37288.4 3515.9 3555.8 3576.6 3596.9 3596.9 30603.8 30648.4 30688.4 30701.5 30720.5 5151.5 5180.4 5192.0 5197.1 5238.3 182152.1 183415.0 183886.0 185030.1 185282.0 38384.8 38877.2 39126.4 48005.3 48964.3 51614.7 51759.7 51795.5 51844.0 51969.5 16239.9 16388.7 16418.7 16459.8 16500.1 13401.9 13503.3 13511.1 13527.2 13539.5 14270.8 14293.8 14355.1 14404.2 14631.8 5706.2 5721.7 5725.5 5802.7 5930.0 991.4 995.9 1002.4 1026.6 1032.1 22966.8 23060.8 23063.2 23120.9 23258.0 1101.2 1102.8 1106.5 1124.4 1125.2 12065.3 12082.8 12199.4 12311.2 12315.9 215249.0 215560.0 216023.0 216953.0 217479.0 53623.0 53858.5 53882.5 53999.5 54074.2 1420.5 1468.9 1469.7 1471.2 1476.4 21821.8 22122.9 22125.2 22396.0 22613.0 37556.0 37558.2 37665.6 37667.6 37739.6 178796.0 179021.0 179992.0 180303.0 181507.0 34138.1 35689.6 36095.8 36137.6 36206.8 45225.8 46375.3 46956.0 46994.5 47683.8 33558.7 33740.2 33876.2 34025.8 34164.0 33658.3 34202.0 34357.8 34372.0 34708.0 37666.2 37768.0 38022.4 38345.0 38395.6 32966.2 33398.0 33413.5 33450.0 34223.7 24760.0 24892.1 24977.6 25042.6 25108.1 03:18:27 INFO - PID 3751 | 03:18:27 INFO - PID 3751 | [#2] jquery.html Cycles:180 Average:33324.67 Median:22608.38 stddev:77462.51 (342.6%) stddev-sans-first:77640.56 03:18:27 INFO - PID 3751 | Values: 478.8 544.9 554.3 563.7 577.7 21970.2 22576.4 22640.3 22654.7 22674.9 23933.5 24058.2 24425.4 24430.3 25303.5 6471.8 6603.2 6651.6 6651.6 6654.2 6170.7 6444.9 6528.0 6529.8 6537.0 6306.5 6321.5 6354.8 6355.0 6355.8 6329.6 6341.7 6353.1 6364.8 6402.1 6121.2 6142.8 6156.0 6157.1 6164.3 28550.3 29107.3 29169.1 29192.9 29198.4 2044.2 2068.5 2072.2 2079.9 2087.6 17993.6 18482.3 18808.6 18917.1 19052.9 2428.5 2434.3 2453.1 2494.3 2507.3 114910.0 120590.4 122915.0 123731.0 133767.0 14538.7 14718.2 14719.2 14883.8 14948.3 22198.4 22290.9 22293.7 22305.9 22330.4 10221.8 10289.5 10295.3 10429.9 10580.5 9648.2 9652.9 9656.6 9718.8 9782.6 8866.6 8922.7 9067.6 9113.7 9130.3 2742.6 2758.9 2759.7 2779.4 2866.1 941.5 954.3 962.7 968.1 968.4 18834.2 19205.5 19373.6 19639.4 19839.3 995.8 1002.6 1003.8 1003.8 1008.2 10715.6 10800.6 10834.9 10967.9 11063.6 449022.0 456887.0 462719.0 465139.0 472772.0 106678.0 107588.0 109787.0 110281.0 112564.4 1035.9 1078.0 1092.2 1124.9 1127.1 20536.4 20632.8 20665.8 20940.8 20972.3 55304.2 56038.0 56762.1 56773.4 57341.7 68231.7 69245.7 69663.0 69804.0 69823.0 14179.1 14412.3 14513.7 14536.9 14606.3 23218.8 23476.0 23622.3 23640.0 23751.7 18505.7 18552.8 18765.2 18871.4 18875.0 16539.8 16831.5 17141.4 17175.3 17285.8 18326.2 18657.5 18986.2 19229.8 19258.2 14216.4 14302.2 14375.5 14409.3 14496.7 18393.9 18476.4 18484.0 18532.9 18657.3 03:18:27 INFO - PID 3751 | 03:18:27 INFO - PID 3751 | [#3] mootools.html Cycles:180 Average:9436.24 Median:14770.15 stddev:6671.86 (45.2%) stddev-sans-first:6662.70 03:18:27 INFO - PID 3751 | Values: 1319.4 1382.5 1389.4 1399.1 1414.5 15130.1 15820.7 15826.7 15832.6 15850.4 15594.7 15627.8 15711.3 15722.2 15728.3 2719.2 2734.2 2787.6 2791.5 2793.1 2606.5 2651.9 2653.5 2659.9 2665.4 2655.1 2767.8 2858.8 2868.4 2871.0 2689.9 2740.8 2752.3 2768.3 2769.4 2731.9 2739.3 2749.9 2752.8 2755.4 14836.5 15152.1 15179.6 15192.8 15219.3 8056.8 8355.0 8372.1 8372.3 8386.2 5595.7 5774.0 5819.5 5881.7 5895.9 1875.8 1883.8 1900.9 1938.2 1945.2 26874.9 27116.6 27130.9 27148.0 27152.5 7450.8 7464.4 7689.1 7696.7 7736.6 17071.9 17184.0 17212.6 17232.1 17233.5 7976.2 8102.7 8146.8 8172.8 8186.3 7460.4 7538.3 7566.8 7580.4 7607.8 4868.4 5026.3 5054.4 5101.4 5109.8 1427.8 1481.1 1495.7 1497.8 1518.6 729.8 881.0 891.1 896.9 906.2 8564.1 8611.0 8629.3 8676.0 8681.9 965.6 965.7 969.6 971.3 978.3 5184.7 5475.9 5492.4 5568.6 5583.3 20802.0 20974.7 21263.6 21856.5 21898.0 20359.4 21420.4 21531.0 21679.1 21771.7 11164.6 11612.5 11642.0 11710.6 11722.4 7897.3 8166.9 8264.3 8269.8 8328.2 18123.2 18583.1 18698.2 19161.0 19325.0 18626.3 18647.3 18722.9 18752.7 18807.9 10599.6 10819.9 10828.0 10905.1 10926.7 13580.5 13691.9 13702.2 13743.2 13820.0 10987.9 11108.3 11405.4 11427.3 11467.0 10867.7 11011.1 11102.2 11256.5 11375.8 10052.1 10059.2 10142.1 10218.5 10240.8 7567.5 7570.3 7586.1 7642.8 7737.1 7415.2 7488.1 7491.7 7495.4 7554.5 03:18:27 INFO - PID 3751 | 03:18:27 INFO - PID 3751 | [#4] prototype.html Cycles:180 Average:5559.62 Median:6260.11 stddev:1547.33 (24.7%) stddev-sans-first:1504.09 03:18:27 INFO - PID 3751 | Values: 486.3 525.5 528.9 529.5 530.1 6348.1 6360.7 6373.5 6382.7 6477.2 6266.4 6281.9 6341.2 6354.6 6356.5 5180.0 5195.9 5222.2 5253.6 5279.8 5220.9 5221.0 5224.6 5230.6 5243.4 4867.4 4973.9 5010.5 5015.9 5054.9 5032.7 5054.7 5056.1 5068.1 5077.6 4492.5 4493.6 4493.9 4505.0 4505.7 6066.7 6227.8 6230.6 6245.1 6253.8 5737.0 5741.5 5747.5 5756.4 5795.8 6528.8 6590.0 6611.2 6659.5 6679.8 4875.8 4928.3 4936.4 4937.7 4981.9 6635.5 6802.0 6856.9 6988.7 7017.3 5025.1 5048.8 5082.9 5093.3 5103.7 5128.3 5155.1 5160.3 5161.2 5188.4 5615.8 5673.9 5698.9 5733.6 5784.3 6663.1 6703.3 6711.8 6713.9 6716.7 1755.8 1763.9 1778.5 1782.5 1795.2 1160.3 1192.5 1220.5 1224.4 1228.8 5791.1 5808.1 5812.4 5878.7 5886.5 6709.3 6811.3 6853.8 6880.9 6923.5 5727.4 5750.5 5792.4 5807.7 5824.5 3574.6 3596.0 3614.9 3620.4 3663.4 6549.5 6556.2 6567.5 6601.2 6606.4 6867.5 6918.4 6961.3 6983.8 7034.2 6133.6 6441.8 6447.1 6509.6 6576.9 6550.2 6701.4 6718.7 6722.6 6758.3 6523.3 6528.5 6587.9 6598.9 6616.4 6309.8 6323.9 6479.0 6551.3 6624.7 5051.8 5055.8 5057.2 5061.3 5080.5 6591.2 6681.1 6789.9 6911.7 6924.7 6413.5 6534.9 6550.7 6596.8 6653.9 6422.7 6436.2 6466.5 6533.5 6554.3 6277.6 6367.3 6376.6 6439.7 6495.2 6582.5 6598.3 6621.4 6625.2 6632.7 6291.9 6304.5 6335.7 6361.5 6361.5 03:18:27 INFO - PID 3751 | 03:18:27 INFO - PID 3751 | [#5] yui.html Cycles:180 Average:24632.32 Median:18411.81 stddev:36407.94 (197.7%) stddev-sans-first:36466.45 03:18:27 INFO - PID 3751 | Values: 896.7 917.4 936.4 938.3 951.9 16465.2 16540.3 16561.0 16703.8 16715.8 15740.1 15797.5 15980.4 16042.0 17203.1 931.0 940.7 943.3 943.3 944.0 951.1 958.0 958.8 959.5 960.4 937.4 964.9 970.5 973.1 1002.2 970.3 979.8 980.4 981.4 981.9 703.9 718.4 718.6 719.2 725.4 17455.6 17619.6 17637.6 17646.6 17650.5 21795.7 22289.0 22455.2 22787.7 22962.9 17112.7 17357.5 17483.5 17530.9 17584.2 3697.8 3767.4 3774.8 3777.9 3778.4 136350.0 139062.0 141458.0 141639.0 143060.0 16079.6 16491.2 16594.6 16738.9 16748.4 30718.0 31644.8 31645.7 31816.2 32089.4 7504.7 7509.4 7571.0 7598.0 7629.9 3770.7 3860.0 3868.8 3870.7 3873.4 5481.7 5575.6 5634.4 5647.5 5660.3 997.4 1019.5 1032.6 1044.0 1044.3 667.3 693.9 697.6 704.7 713.6 11958.0 12196.1 12236.6 12606.7 13014.6 696.5 703.8 704.1 720.9 721.7 5654.0 5662.2 5676.5 5758.3 5761.1 123426.0 124255.0 127035.0 129788.5 129813.0 112314.0 113815.4 113995.0 114906.4 118581.0 96900.0 100557.0 100952.0 101471.5 101742.5 10402.5 10604.1 10681.6 10829.7 10860.6 43765.3 44105.3 44890.1 45543.5 45902.5 54985.5 56018.7 57166.7 57287.4 58966.0 15917.5 16121.0 16148.8 16294.4 16453.6 18243.7 18366.4 18457.2 18475.8 18516.6 15142.9 15258.8 15359.4 15454.2 15494.9 16352.4 16628.8 16717.1 16739.2 16933.2 15899.7 15912.6 16066.6 16250.6 16458.8 11758.2 11846.7 12060.5 12165.9 12230.8 11949.9 12042.8 12044.5 12618.7 12622.5 03:18:27 INFO - PID 3751 | -------- Summary: end -------- 03:18:27 INFO - PID 3751 | 03:18:27 INFO - TEST-INFO | 3751: exit 0 03:18:27 INFO - TEST-OK | dromaeo_css | took 1111100ms 03:18:27 INFO - TEST-START | kraken 03:18:27 INFO - Initialising browser for kraken test... 03:18:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54079/getInfo.html -profile /tmp/tmpW1SwTG/profile 03:18:27 INFO - TEST-INFO | started process 4153 (/builds/slave/test/build/application/firefox/firefox http://localhost:54079/getInfo.html) 03:18:32 INFO - TEST-INFO | 4153: exit 0 03:18:32 INFO - Browser initialized. 03:18:32 INFO - Running cycle 1/1 for kraken test... 03:18:32 INFO - Using env: {'DISPLAY': ':0', 03:18:32 INFO - 'HOME': '/home/cltbld', 03:18:32 INFO - 'JSGC_DISABLE_POISONING': '1', 03:18:32 INFO - 'LANG': 'en_US.UTF-8', 03:18:32 INFO - 'LANGUAGE': 'en_US:en', 03:18:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:18:32 INFO - 'LOGNAME': 'cltbld', 03:18:32 INFO - 'MAIL': '/var/mail/cltbld', 03:18:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:18:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:18:32 INFO - 'MOZ_CRASHREPORTER': '1', 03:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:18:32 INFO - 'MOZ_NO_REMOTE': '1', 03:18:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:18:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:32 INFO - 'NO_EM_RESTART': '1', 03:18:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:32 INFO - 'PWD': '/builds/slave/test', 03:18:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:18:32 INFO - 'RUST_BACKTRACE': 'full', 03:18:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:18:32 INFO - 'SHELL': '/bin/bash', 03:18:32 INFO - 'SHLVL': '1', 03:18:32 INFO - 'STYLO_FORCE_DISABLED': '1', 03:18:32 INFO - 'TERM': 'linux', 03:18:32 INFO - 'TMOUT': '86400', 03:18:32 INFO - 'USER': 'cltbld', 03:18:32 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535', 03:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:32 INFO - '_': '/tools/buildbot/bin/python'} 03:18:32 INFO - TEST-INFO | started process 4386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW1SwTG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:33 INFO - PID 4386 | 03:18:33 INFO - PID 4386 | (/builds/slave/test/build/application/firefox/firefox:4435): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:18:33 INFO - PID 4386 | 03:18:44 INFO - PID 4386 | RSS: Main: 173981696 03:18:44 INFO - PID 4386 | 03:18:46 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54079/tests/kraken/driver.html?testName=audio-beat-detection) 03:18:47 INFO - PID 4386 | RSS: Main: 178253824 03:18:47 INFO - PID 4386 | 03:18:50 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54079/tests/kraken/driver.html?testName=audio-dft) 03:18:51 INFO - PID 4386 | RSS: Main: 178741248 03:18:51 INFO - PID 4386 | 03:18:54 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54079/tests/kraken/driver.html?testName=audio-fft) 03:18:54 INFO - PID 4386 | RSS: Main: 174411776 03:18:54 INFO - PID 4386 | 03:18:56 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54079/tests/kraken/driver.html?testName=audio-oscillator) 03:18:57 INFO - PID 4386 | RSS: Main: 175267840 03:18:57 INFO - PID 4386 | 03:18:59 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54079/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:19:00 INFO - PID 4386 | RSS: Main: 175370240 03:19:00 INFO - PID 4386 | 03:19:03 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54079/tests/kraken/driver.html?testName=imaging-darkroom) 03:19:03 INFO - PID 4386 | RSS: Main: 177602560 03:19:03 INFO - PID 4386 | 03:19:07 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54079/tests/kraken/driver.html?testName=imaging-desaturate) 03:19:08 INFO - PID 4386 | RSS: Main: 178192384 03:19:08 INFO - PID 4386 | 03:19:11 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54079/tests/kraken/driver.html?testName=json-parse-financial) 03:19:11 INFO - PID 4386 | RSS: Main: 178143232 03:19:11 INFO - PID 4386 | 03:19:13 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54079/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:19:14 INFO - PID 4386 | RSS: Main: 178204672 03:19:14 INFO - PID 4386 | 03:19:15 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:19:16 INFO - PID 4386 | RSS: Main: 178515968 03:19:16 INFO - PID 4386 | 03:19:18 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:19:19 INFO - PID 4386 | RSS: Main: 175652864 03:19:19 INFO - PID 4386 | 03:19:21 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:19:22 INFO - PID 4386 | RSS: Main: 175796224 03:19:22 INFO - PID 4386 | 03:19:25 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:19:25 INFO - PID 4386 | RSS: Main: 175505408 03:19:25 INFO - PID 4386 | 03:19:27 INFO - PID 4386 | Cycle 1(1): loaded http://localhost:54079/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54079/tests/kraken/driver.html?testName=ai-astar) 03:19:28 INFO - PID 4386 | RSS: Main: 177254400 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | __start_tp_report 03:19:28 INFO - PID 4386 | _x_x_mozilla_page_load 03:19:28 INFO - PID 4386 | _x_x_mozilla_page_load_details 03:19:28 INFO - PID 4386 | |i|pagename|runs| 03:19:28 INFO - PID 4386 | |0;ai-astar;108;107;109;108;108;109;108;110;106;108 03:19:28 INFO - PID 4386 | |1;audio-beat-detection;118;117;118;122;116;115;119;120;119;115 03:19:28 INFO - PID 4386 | |2;audio-dft;163;163;163;161;163;162;161;165;178;164 03:19:28 INFO - PID 4386 | |3;audio-fft;73;73;74;74;73;74;75;76;77;74 03:19:28 INFO - PID 4386 | |4;audio-oscillator;79;79;80;80;79;79;87;79;78;79 03:19:28 INFO - PID 4386 | |5;imaging-gaussian-blur;115;113;113;114;114;114;114;116;115;114 03:19:28 INFO - PID 4386 | |6;imaging-darkroom;164;148;148;148;148;147;148;149;150;149 03:19:28 INFO - PID 4386 | |7;imaging-desaturate;99;94;108;93;93;93;93;94;94;95 03:19:28 INFO - PID 4386 | |8;json-parse-financial;54;55;53;54;54;55;54;54;53;55 03:19:28 INFO - PID 4386 | |9;json-stringify-tinderbox;37;38;37;37;37;38;38;37;38;38 03:19:28 INFO - PID 4386 | |10;stanford-crypto-aes;76;75;77;74;78;81;73;75;74;74 03:19:28 INFO - PID 4386 | |11;stanford-crypto-ccm;120;110;118;124;121;112;118;111;113;113 03:19:28 INFO - PID 4386 | |12;stanford-crypto-pbkdf2;178;170;170;172;172;171;174;169;176;168 03:19:28 INFO - PID 4386 | |13;stanford-crypto-sha256-iterative;70;68;69;65;66;67;73;64;74;66 03:19:28 INFO - PID 4386 | __end_tp_report 03:19:28 INFO - PID 4386 | __start_cc_report 03:19:28 INFO - PID 4386 | _x_x_mozilla_cycle_collect,980 03:19:28 INFO - PID 4386 | __end_cc_report 03:19:28 INFO - PID 4386 | __startTimestamp1505470768020__endTimestamp 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | ------- Summary: start ------- 03:19:28 INFO - PID 4386 | Number of tests: 14 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#0] ai-astar Cycles:10 Average:108.10 Median:108.00 stddev:1.10 (1.0%) stddev-sans-first:1.17 03:19:28 INFO - PID 4386 | Values: 108.0 107.0 109.0 108.0 108.0 109.0 108.0 110.0 106.0 108.0 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#1] audio-beat-detection Cycles:10 Average:117.90 Median:118.50 stddev:2.23 (1.9%) stddev-sans-first:2.37 03:19:28 INFO - PID 4386 | Values: 118.0 117.0 118.0 122.0 116.0 115.0 119.0 120.0 119.0 115.0 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:4.97 (3.0%) stddev-sans-first:5.25 03:19:28 INFO - PID 4386 | Values: 163.0 163.0 163.0 161.0 163.0 162.0 161.0 165.0 178.0 164.0 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#3] audio-fft Cycles:10 Average:74.30 Median:74.00 stddev:1.34 (1.8%) stddev-sans-first:1.33 03:19:28 INFO - PID 4386 | Values: 73.0 73.0 74.0 74.0 73.0 74.0 75.0 76.0 77.0 74.0 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#4] audio-oscillator Cycles:10 Average:79.90 Median:79.00 stddev:2.56 (3.2%) stddev-sans-first:2.69 03:19:28 INFO - PID 4386 | Values: 79.0 79.0 80.0 80.0 79.0 79.0 87.0 79.0 78.0 79.0 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 03:19:28 INFO - PID 4386 | Values: 115.0 113.0 113.0 114.0 114.0 114.0 114.0 116.0 115.0 114.0 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:148.50 stddev:5.02 (3.4%) stddev-sans-first:0.87 03:19:28 INFO - PID 4386 | Values: 164.0 148.0 148.0 148.0 148.0 147.0 148.0 149.0 150.0 149.0 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:94.00 stddev:4.72 (5.0%) stddev-sans-first:4.84 03:19:28 INFO - PID 4386 | Values: 99.0 94.0 108.0 93.0 93.0 93.0 93.0 94.0 94.0 95.0 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 03:19:28 INFO - PID 4386 | Values: 54.0 55.0 53.0 54.0 54.0 55.0 54.0 54.0 53.0 55.0 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#9] json-stringify-tinderbox Cycles:10 Average:37.50 Median:38.00 stddev:0.53 (1.4%) stddev-sans-first:0.53 03:19:28 INFO - PID 4386 | Values: 37.0 38.0 37.0 37.0 37.0 38.0 38.0 37.0 38.0 38.0 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.50 stddev:2.41 (3.2%) stddev-sans-first:2.55 03:19:28 INFO - PID 4386 | Values: 76.0 75.0 77.0 74.0 78.0 81.0 73.0 75.0 74.0 74.0 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#11] stanford-crypto-ccm Cycles:10 Average:116.00 Median:118.00 stddev:4.81 (4.1%) stddev-sans-first:4.88 03:19:28 INFO - PID 4386 | Values: 120.0 110.0 118.0 124.0 121.0 112.0 118.0 111.0 113.0 113.0 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.00 stddev:3.16 (1.8%) stddev-sans-first:2.50 03:19:28 INFO - PID 4386 | Values: 178.0 170.0 170.0 172.0 172.0 171.0 174.0 169.0 176.0 168.0 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.50 stddev:3.33 (4.9%) stddev-sans-first:3.46 03:19:28 INFO - PID 4386 | Values: 70.0 68.0 69.0 65.0 66.0 67.0 73.0 64.0 74.0 66.0 03:19:28 INFO - PID 4386 | -------- Summary: end -------- 03:19:28 INFO - PID 4386 | 03:19:28 INFO - PID 4386 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:19:28 INFO - TEST-INFO | 4386: exit 0 03:19:28 INFO - TEST-OK | kraken | took 61048ms 03:19:28 INFO - SUITE-END | took 1172s 03:19:29 INFO - Completed test suite (00:19:32) 03:19:29 INFO - javascript benchmark 03:19:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8534.03021867387, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3163.1301392117166, 3163.8101713897167, 3169.223540232642, 3183.570218020568, 3219.1308346746364, 6219.689015549227, 6322.241331040276, 6416.518761092913, 6436.613803171813, 6461.547691661585, 6303.275123360815, 6312.6212427254395, 6342.524310676695, 6349.42855143037, 6473.838154046151, 5833.649981001132, 5872.530197584194, 5928.49607783339, 5931.495822855041, 5954.345022047572, 5681.687507187103, 5847.386024467433, 5870.148828419877, 5889.499392551638, 5965.850853728648, 5817.7091145442555, 5914.585978981473, 5915.408459154093, 5964.3737407572235, 5983.970080149615, 5702.030654788696, 5800.361960184377, 5816.941830581683, 5865.325487568942, 5876.764929402819, 5819.9418005819825, 5835.824925252249, 5837.270341207349, 5856.736446859902, 5870.618409803349, 6287.402696743802, 6418.711157997901, 6425.710843012076, 6443.162388889415, 6489.70796314167, 6834.043233947252, 6836.863262734767, 6865.622390768505, 6937.791866244021, 6940.063091482636, 6710.42961348286, 6854.0404343391965, 6857.382835544825, 6862.759803406907, 6864.24493305736, 6287.308396076428, 6297.464715499188, 6317.368263173692, 6395.552311338208, 6428.485721142298, 6998.545094568837, 7008.299170083053, 7112.822179445555, 7118.60847653384, 7126.501144919909, 6697.464202863759, 6726.8654626908165, 6749.763758268437, 6800.557963732342, 6829.6243706596615, 6736.0, 6805.115335006517, 6819.24988251292, 6902.068220790129, 6956.200036995709, 6757.155355580552, 6757.898631520531, 6839.931600684029, 6844.93155068443, 6880.793576192722, 6823.69293381799, 6919.481038922101, 6922.8615427692175, 6931.930680693229, 6933.37599616037, 5360.839174824761, 5361.329833770778, 5402.054640437907, 5410.0, 5412.702301373383, 4575.725456472623, 4656.41794775653, 4673.626109911199, 4682.180618391768, 4691.648126390534, 5881.823545293648, 5890.676012819336, 5892.440218179266, 5895.380984996599, 5928.466438020512, 6872.484563657746, 6879.3120687930805, 6950.965245173742, 6956.513044086865, 6971.82570435733, 5854.121881717691, 5858.238429004202, 5922.170896074467, 5937.960856850034, 5942.257217847769, 5714.200011998323, 5783.942160578425, 5872.970635146882, 5936.881262374728, 5951.940480595139, 6513.869722605521, 6540.313267106981, 6561.311062338481, 6569.901451478136, 6577.80266592003, 6805.081314022544, 6881.41507971828, 6918.896216556856, 6921.169459664872, 6952.652367381712, 6546.410823025951, 6572.704228309642, 6632.90050649231, 6673.265940746611, 6700.4639628830555, 6763.12079429671, 6789.456843452611, 6848.9657551711925, 6870.587764734132, 6877.071595334566, 6673.9666301668185, 6800.761973330909, 6813.216480104653, 6813.454923606, 6903.792886213421, 6649.534532582673, 6701.229358623626, 6701.731930722716, 6703.396694297537, 6718.395344419026, 6670.733170673118, 6730.932690673227, 6731.730730770714, 6736.427403670743, 6745.730170793114, 6595.076689263411, 6595.142631457879, 6673.9666301668185, 6683.665816709048, 6695.230048544479, 6580.243272023778, 6604.801855944329, 6701.128853249046, 6733.595984240961, 6746.35909588608, 6303.306636269915, 6442.35576442352, 6497.94835497166, 6592.67036648156, 6603.834904127243], "value": 6233.30283377711, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [849.5837039850472, 882.2456799436482, 888.2893685051956, 888.3204348673266, 895.046775184429, 40693.0, 41383.58616413835, 41708.79145604268, 41719.37420938684, 41736.0, 37397.43903841444, 37455.25089498215, 37516.24967500648, 37864.62135378645, 37913.431298530544, 6991.300869913019, 7089.078419805418, 7131.714731410737, 7134.357907788298, 7153.964230178868, 7033.296670332977, 7120.4659650526155, 7131.108611423572, 7134.072570565819, 7137.643117844113, 7702.537847729154, 7985.241402066823, 7994.880076798852, 7996.640151193181, 7996.720114795983, 7892.644830982591, 7915.762527124196, 7964.8805267921025, 7965.681372745054, 7968.721094761713, 7529.510581812219, 7737.9226207737765, 7745.690172393098, 7753.96123019387, 7754.883676744853, 36817.26365472702, 37203.0, 37219.0, 37239.0, 37288.44067338992, 3515.894523164284, 3555.7510974231814, 3576.624454432273, 3596.892093237207, 3596.9100772480638, 30603.846980764953, 30648.387032259452, 30688.386232275454, 30701.539476907863, 30720.53919191214, 5151.484851514856, 5180.352455943007, 5192.0, 5197.090509160919, 5238.319018527567, 182152.08923955297, 183415.0, 183886.0, 185030.07484962622, 185282.0, 38384.80807596, 38877.22245555073, 39126.41310380347, 48005.279920801215, 48964.26553601699, 51614.74192629088, 51759.74120129375, 51795.482045179066, 51844.0, 51969.48030519646, 16239.944403613727, 16388.672226555642, 16418.6716265674, 16459.83540164607, 16500.092494912897, 13401.93299033518, 13503.257320847448, 13511.05422620407, 13527.188368697909, 13539.526116586068, 14270.785938210935, 14293.78559321611, 14355.138691678532, 14404.20776857262, 14631.780523292158, 5706.201131841545, 5721.713914304268, 5725.5133313667975, 5802.6808525531505, 5930.0, 991.4299277915228, 995.9253056020827, 1002.3785253143097, 1026.6150193677372, 1032.0762917189074, 22966.770332296463, 23060.769392306196, 23063.19278825233, 23120.884395577916, 23258.0, 1101.2236373356764, 1102.8456016157745, 1106.4799544214206, 1124.4490199802037, 1125.1617544929081, 12065.336406497552, 12082.758344833053, 12199.390030498616, 12311.19977201497, 12315.93842030802, 215249.0, 215560.0, 216023.0, 216953.0, 217479.0, 53623.0, 53858.461415386126, 53882.46117538775, 53999.46000539944, 54074.188887166725, 1420.5241244183107, 1468.8971771976073, 1469.7427950108688, 1471.1687896338535, 1476.3946781819618, 21821.78178218261, 22122.889385552968, 22125.225617103326, 22396.0, 22613.0, 37556.0, 37558.248835023696, 37665.62334376621, 37667.623323767504, 37739.62260377471, 178796.0, 179021.0, 179992.0, 180303.0, 181507.0, 34138.14654633555, 35689.64310356863, 36095.81952090223, 36137.63862361343, 36206.818965905004, 45225.773871130434, 46375.304370435144, 46956.0, 46994.53005469902, 47683.76158119187, 33558.66441335555, 33740.156496087795, 33876.15309617279, 34025.82987085049, 34164.0, 33658.32683346368, 34202.0, 34357.82821085879, 34372.0, 34708.0, 37666.24667506689, 37768.0, 38022.42966355452, 38345.041373965876, 38395.6160438392, 32966.175845604055, 33398.0, 33413.49879751854, 33450.0, 34223.657763422045, 24760.0, 24892.128775492773, 24977.625335620345, 25042.62436063424, 25108.12121575736], "value": 17139.512046827625, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.78215411987543, 544.8801263721982, 554.2960440240892, 563.6927874308501, 577.725580349334, 21970.231041913536, 22576.43558911028, 22640.320790376296, 22654.66018009731, 22674.88662556689, 23933.5213295734, 24058.157964471247, 24425.389365265877, 24430.267091987225, 25303.493930121385, 6471.805845824621, 6603.240627327871, 6651.634160121192, 6651.634160121192, 6654.234763002244, 6170.660613666247, 6444.935550644504, 6527.967360163192, 6529.836754081162, 6536.967315163418, 6306.527010474209, 6321.46267567255, 6354.7775827846035, 6355.0, 6355.777547785829, 6329.588576742543, 6341.682915854212, 6353.0788035734795, 6364.809055728336, 6402.103705481236, 6121.204243448323, 6142.84642883927, 6156.045812899008, 6157.107219453199, 6164.321924588292, 28550.286242843886, 29107.272318192005, 29169.124926252036, 29192.8540357299, 29198.416031679248, 2044.1721102953327, 2068.5449201175716, 2072.1814883121083, 2079.854410191287, 2087.6033553624916, 17993.64012719738, 18482.2607095716, 18808.62382752351, 18917.14872830726, 19052.90473547637, 2428.477877256398, 2434.2514899042367, 2453.1291391556097, 2494.301595553248, 2507.348089496744, 114910.0, 120590.3970480142, 122915.0, 123731.0, 133767.0, 14538.689519021938, 14718.190499522629, 14719.207196767395, 14883.776743348642, 14948.252587370805, 22198.445038874157, 22290.88854555717, 22293.66559501609, 22305.888470557544, 22330.441738956655, 10221.795564088676, 10289.485525723683, 10295.330803497749, 10429.895701043044, 10580.523876425425, 9648.179904708179, 9652.876367199206, 9656.565454554562, 9718.757031074138, 9782.608695652236, 8866.645334186689, 8922.687705930392, 9067.637294508146, 9113.689465005416, 9130.269578433843, 2742.561190209557, 2758.875850586688, 2759.7378249066305, 2779.416322572242, 2866.054202113298, 941.4915945389413, 954.2509130332655, 962.711186644004, 968.1045033344128, 968.4479846487575, 18834.15246313892, 19205.519862003282, 19373.612527749367, 19639.410817675493, 19839.30562430308, 995.7809281957958, 1002.644061358222, 1003.8092762375126, 1003.82934901067, 1008.2488546033252, 10715.571377144983, 10800.567977280978, 10834.891651083388, 10967.941552219758, 11063.612773553048, 449022.01955960697, 456887.0, 462719.0, 465139.0, 472772.0, 106678.0, 107588.0, 109787.0, 110281.0, 112564.43717781358, 1035.9326643768131, 1078.0, 1092.1535809747509, 1124.9043831274269, 1127.0926903842485, 20536.38390848277, 20632.793672063086, 20665.793342066387, 20940.790592093883, 20972.26597069095, 55304.17043744428, 56038.0, 56762.14856777069, 56773.432265678464, 57341.71329143494, 68231.65884170547, 69245.65377173283, 69663.0, 69804.0, 69823.0, 14179.078359906573, 14412.279386030867, 14513.709725805636, 14536.927315363355, 14606.269686515845, 23218.767812322338, 23476.0, 23622.29133126009, 23640.0, 23751.693656848347, 18505.72241416353, 18552.81447185511, 18765.155567999198, 18871.433856983764, 18875.0, 16539.75190372121, 16831.495055148363, 17141.400050998156, 17175.31298748036, 17285.827141728925, 18326.17532211027, 18657.507399408285, 18986.240550377832, 19229.8077019228, 19258.22967081301, 14216.431342746175, 14302.213378264296, 14375.496857609933, 14409.279536023367, 14496.710065798414, 18393.908030459763, 18476.353327633467, 18484.0, 18532.907335463235, 18657.346992855186], "value": 11842.461467557023, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.3930791835755, 1382.5092092307232, 1389.4442223110748, 1399.0626280392132, 1414.483713444593, 15130.092194468325, 15820.683586328267, 15826.683466330667, 15832.604184895383, 15850.445234416784, 15594.688106237896, 15627.843721562782, 15711.292991815368, 15722.213889305518, 15728.292226849791, 2719.2250208690575, 2734.1524127520433, 2787.6236708044357, 2791.4696207720467, 2793.0503628766214, 2606.5162907268113, 2651.9071832485865, 2653.4825708986755, 2659.9335016624545, 2665.4269332093595, 2655.137080448852, 2767.764739997103, 2858.757005654522, 2868.4263147370507, 2870.9569356459565, 2689.8789554470095, 2740.753332200102, 2752.270648278208, 2768.2664094015004, 2769.4322663853864, 2731.9180424587294, 2739.2740923655247, 2749.8625068746683, 2752.779777617806, 2755.3938133610573, 14836.480723174745, 15152.090874547563, 15179.620509487351, 15192.772108418383, 15219.315130819139, 8056.758297251092, 8355.03917049541, 8372.079071302152, 8372.28835548979, 8386.203310685476, 5595.7481913313995, 5773.971130144364, 5819.53443724501, 5881.67650779207, 5895.911561326584, 1875.8217969292896, 1883.8398736107447, 1900.8669393142486, 1938.1569017477302, 1945.2413558712115, 26874.86562567194, 27116.59325110125, 27130.864345678146, 27148.0, 27152.456950860873, 7450.813729656802, 7464.365528929993, 7689.077310722749, 7696.7306144284685, 7736.574488403192, 17071.914640426967, 17184.0, 17212.569685757957, 17232.138393080546, 17233.482995510156, 7976.162502937108, 8102.716404925799, 8146.837063258702, 8172.754817355489, 8186.2632363087605, 7460.365868901095, 7538.283863033003, 7566.810829729191, 7580.431467639949, 7607.809804754926, 4868.440129385166, 5026.346574945233, 5054.444011158769, 5101.387833460009, 5109.846704598868, 1427.7644188708746, 1481.0595272002356, 1495.6634757179547, 1497.7828214908777, 1518.5899807052035, 729.8175456135966, 880.9735707928772, 891.1044400377579, 896.9461832290084, 906.2478143141177, 8564.14358564151, 8611.0, 8629.266512346521, 8676.045634980148, 8681.869771953427, 965.5510187762724, 965.6716716316486, 969.5892476446753, 971.3006635222629, 978.256525040974, 5184.7407629618365, 5475.917861232085, 5492.368377636623, 5568.554515638739, 5583.274174357389, 20802.0, 20974.685379719318, 21263.574728505344, 21856.453588660093, 21898.01458934352, 20359.389218323475, 21420.357389278346, 21531.0, 21679.132834686752, 21771.67342489864, 11164.553417863357, 11612.535498580131, 11642.0, 11710.648680539427, 11722.355270460206, 7897.289243968071, 8166.877496837671, 8264.338852891875, 8269.751907442786, 8328.167183281623, 18123.184456699742, 18583.070846457893, 18698.158582864075, 19161.041947902828, 19325.0, 18626.254949801856, 18647.254109835998, 18722.906385467984, 18752.718709219647, 18807.90596047011, 10599.576016959236, 10819.891801081889, 10828.0, 10905.073068789241, 10926.6721998337, 13580.45678172862, 13691.931540342235, 13702.177869327872, 13743.244121573409, 13820.0, 10987.945060274968, 11108.277961932772, 11405.429728513707, 11427.257228280136, 11466.967972882481, 10867.673969780602, 11011.119110471303, 11102.167337449562, 11256.493457794255, 11375.829362559403, 10052.145567626834, 10059.195264378686, 10142.137918277029, 10218.540165692413, 10240.846387304346, 7567.545947243183, 7570.280823321996, 7586.089669239726, 7642.770716878503, 7737.14891361961, 7415.184329723834, 7488.101427828696, 7491.73778917757, 7495.36289415384, 7554.508956917783], "value": 6762.053933286444, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.31186870578136, 525.5270256768908, 528.8704267454474, 529.52078369076, 530.1385248970423, 6348.079528468375, 6360.713767880445, 6373.521985851056, 6382.712777924993, 6477.157969463969, 6266.404691554295, 6281.937180628192, 6341.207349081365, 6354.586951848127, 6356.491480681546, 5180.0, 5195.9480405195845, 5222.216667499877, 5253.553447956909, 5279.762410691509, 5220.895582088375, 5220.981908527839, 5224.582033437335, 5230.607704422165, 5243.370795504526, 4867.415910090794, 4973.880876802708, 5010.498950104997, 5015.874603134933, 5054.862655902411, 5032.672876263049, 5054.69671819692, 5056.140456122431, 5068.08774420606, 5077.593792496591, 4492.483364413101, 4493.640508759291, 4493.932591011137, 4505.0, 4505.662075344362, 6066.695660433028, 6227.844303892393, 6230.5638605297645, 6245.125682404467, 6253.812385628438, 5736.971315143439, 5741.45456181662, 5747.453991870766, 5756.395578464285, 5795.797147099831, 6528.77149299777, 6590.0, 6611.239707433659, 6659.467242620579, 6679.76620818269, 4875.804967801284, 4928.26076088586, 4936.358273424432, 4937.703737775745, 4981.9252711209365, 6635.535512514126, 6802.0, 6856.862862742767, 6988.685509152049, 7017.2631873653045, 5025.120603894304, 5048.8232911848645, 5082.932584157368, 5093.337866077386, 5103.7192954387865, 5128.282040514331, 5155.097857874932, 5160.251763494272, 5161.174212126042, 5188.403333616607, 5615.775368985276, 5673.886522269531, 5698.943010569924, 5733.598648094593, 5784.305883294031, 6663.133792607027, 6703.3296670332575, 6711.832204194837, 6713.899291510631, 6716.731330746813, 1755.824417558234, 1763.9294428222984, 1778.4575704410279, 1782.4919897829056, 1795.2370242646823, 1160.3328086350382, 1192.451472322724, 1220.523166967961, 1224.3878060969516, 1228.8218208359738, 5791.0734282514595, 5808.128780682847, 5812.418758124154, 5878.676672782953, 5886.470217680429, 6709.329067093252, 6811.318868113149, 6853.760118395832, 6880.869204511935, 6923.515353925278, 5727.365411910485, 5750.482456578928, 5792.391798861143, 5807.651540907559, 5824.475797178275, 3574.5889222739197, 3595.957172419969, 3614.8915532534065, 3620.420732682811, 3663.413853783382, 6549.476041916635, 6556.164274003287, 6567.474602031826, 6601.174853143357, 6606.372394622503, 6867.484938629623, 6918.377346038881, 6961.26906674802, 6983.755568555076, 7034.19106802714, 6133.560938281793, 6441.838954026187, 6447.09810605863, 6509.641969691617, 6576.934230657728, 6550.213974323112, 6701.430378417889, 6718.697658605277, 6722.63868065967, 6758.2565917748025, 6523.31505191967, 6528.543001990005, 6587.912994355877, 6598.931496853986, 6616.4045235929, 6309.842253943688, 6323.936760632335, 6479.0, 6551.344865513411, 6624.735010599522, 5051.772670229922, 5055.848324550122, 5057.241413787961, 5061.291419201241, 5080.517350851663, 6591.176102987127, 6681.095887671991, 6789.947558128498, 6911.723531058701, 6924.653767311514, 6413.518986076157, 6534.901976470452, 6550.672466376757, 6596.769113081019, 6653.866922661617, 6422.719934423212, 6436.16329877113, 6466.482681385572, 6533.477321814338, 6554.311797261219, 6277.560570760185, 6367.267764207176, 6376.585521941059, 6439.710213040518, 6495.220573531206, 6582.473402127914, 6598.307177746459, 6621.377762448231, 6625.17185351831, 6632.734690612321, 6291.874162516816, 6304.464120549805, 6335.65153916539, 6361.459275961595, 6361.522885783492], "value": 5102.283392470601, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.6816780043089, 917.3945196170527, 936.4240991790051, 938.3478482454697, 951.900050494698, 16465.176741162937, 16540.255688494017, 16561.0, 16703.83296167038, 16715.83284167158, 15740.055596664179, 15797.526074217792, 15980.360785568593, 16042.0, 17203.139843007863, 930.9767255818608, 940.7177846646013, 943.2972435535536, 943.32552225159, 943.9858402123974, 951.0584521323909, 958.0, 958.8274110660078, 959.4770849886794, 960.4477425480342, 937.3579098317674, 964.9228061755077, 970.5001924009141, 973.0852998181722, 1002.1932344462705, 970.3207754571793, 979.8236317462854, 980.4313498171043, 981.4356744871692, 981.8674478945358, 703.8908969109796, 718.3893690363202, 718.622723070387, 719.230423446912, 725.3979197266257, 17455.563610909703, 17619.559511012198, 17637.64724705499, 17646.558836029075, 17650.470485885315, 21795.67306490404, 22289.0, 22455.214067507557, 22787.658185127235, 22962.885185573967, 17112.657746844994, 17357.47927562175, 17483.475495735147, 17530.91234543819, 17584.208710608054, 3697.8335974880924, 3767.416050512175, 3774.8490060397826, 3777.9055523611855, 3778.395456726938, 136350.0, 139062.0, 141458.0, 141639.0, 143059.99999999895, 16079.598010049609, 16491.17544122789, 16594.58513537147, 16738.916305418395, 16748.41380551675, 30718.0, 31644.841775791436, 31645.683543164734, 31816.204594885312, 32089.35821283608, 7504.737334193277, 7509.399248060142, 7570.962145189239, 7597.962010189914, 7629.8855517167285, 3770.7171962102952, 3859.96140038596, 3868.825902834379, 3870.7484013539593, 3873.4383514390256, 5481.725913704299, 5575.637583557056, 5634.352049514277, 5647.548196144381, 5660.29246344207, 997.3716558568055, 1019.4800651667703, 1032.6282538286212, 1044.0186224948525, 1044.3420644993605, 667.3393340592778, 693.8889777635554, 697.6058526932267, 704.7040243097911, 713.6396119959387, 11958.0, 12196.146269761031, 12236.571719989757, 12606.747865042831, 13014.609561713163, 696.4567637242959, 703.7853454696265, 704.1163340008256, 720.935115839577, 721.6932803558467, 5653.95401850659, 5662.235598194274, 5676.545876329884, 5758.280214973129, 5761.107028410603, 123426.0, 124255.0, 127035.0, 129788.5105744709, 129813.0, 112314.0, 113815.43092284485, 113995.0, 114906.42546787212, 118581.0, 96900.0, 100557.0, 100952.0, 101471.49264253631, 101742.49128754309, 10402.531886064993, 10604.098651614699, 10681.57273709043, 10829.729256768644, 10860.619878304222, 43765.34351984659, 44105.338419923086, 44890.10219795651, 45543.54456455393, 45902.54097459116, 54985.450145498035, 56018.71480374849, 57166.7141664289, 57287.427125729875, 58966.0, 15917.522474325326, 16121.0, 16148.838511614733, 16294.42969496062, 16453.58866028311, 18243.726344104583, 18366.449006529827, 18457.16942737607, 18475.815241847948, 18516.629667406847, 15142.924285378944, 15258.847411525743, 15359.385624574892, 15454.227288635298, 15494.922525387301, 16352.427665031666, 16628.75056874172, 16717.080560569284, 16739.163041848104, 16933.238004290084, 15899.682006360039, 15912.602184945006, 16066.598335041717, 16250.593735156715, 16458.75311870347, 11758.235714678518, 11846.703832404259, 12060.51757929673, 12165.939170304091, 12230.755384892074, 11949.940250298692, 12042.75914481723, 12044.51821927113, 12618.747625047632, 12622.495100195889], "value": 8849.086270198637, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 107.0, 109.0, 108.0, 108.0, 109.0, 108.0, 110.0, 106.0, 108.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 122.0, 116.0, 115.0, 119.0, 120.0, 119.0, 115.0], "value": 117.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 161.0, 163.0, 162.0, 161.0, 165.0, 178.0, 164.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 74.0, 73.0, 74.0, 75.0, 76.0, 77.0, 74.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 80.0, 79.0, 79.0, 87.0, 79.0, 78.0, 79.0], "value": 79.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 116.0, 115.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 149.0, 150.0, 149.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 108.0, 93.0, 93.0, 93.0, 93.0, 94.0, 94.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 53.0, 54.0, 54.0, 55.0, 54.0, 54.0, 53.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 37.0, 37.0, 38.0, 38.0, 37.0, 38.0, 38.0], "value": 37.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 74.0, 78.0, 81.0, 73.0, 75.0, 74.0, 74.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 110.0, 118.0, 124.0, 121.0, 112.0, 118.0, 111.0, 113.0, 113.0], "value": 116.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 170.0, 170.0, 172.0, 172.0, 171.0, 174.0, 169.0, 176.0, 168.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 65.0, 66.0, 67.0, 73.0, 64.0, 74.0, 66.0], "value": 68.2, "unit": "score"}]}]} 03:19:29 INFO - Return code: 0 03:19:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:19:29 INFO - # TBPL SUCCESS # 03:19:29 INFO - Running post-action listener: _package_coverage_data 03:19:29 INFO - Running post-action listener: _resource_record_post_action 03:19:29 INFO - [mozharness: 2017-09-15 10:19:29.286254Z] Finished run-tests step (success) 03:19:29 INFO - Running post-run listener: _resource_record_post_run 03:19:29 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 13443072; Write bytes: 460500992; Read time: 4168; Write time: 623148 03:19:29 INFO - TinderboxPrint: CPU usage
13.2% 03:19:29 INFO - TinderboxPrint: I/O read bytes / time
13,443,072 / 4,168 03:19:29 INFO - TinderboxPrint: I/O write bytes / time
460,500,992 / 623,148 03:19:29 INFO - TinderboxPrint: CPU idle
8,244.3 (86.8%) 03:19:29 INFO - TinderboxPrint: CPU user
1,193.0 (12.6%) 03:19:29 INFO - TinderboxPrint: Swap in / out
0 / 0 03:19:29 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 115097600; Read time: 316; Write time: 152148 03:19:29 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:29 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 11210752; Write bytes: 312066048; Read time: 3336; Write time: 403572 03:19:29 INFO - Running post-run listener: _upload_blobber_files 03:19:29 INFO - Blob upload gear active. 03:19:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:19:29 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:29 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:29 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:30 INFO - (blobuploader) - INFO - Open directory for files ... 03:19:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:19:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:19:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:37 INFO - (blobuploader) - INFO - Done attempting. 03:19:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:19:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:19:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:38 INFO - (blobuploader) - INFO - Done attempting. 03:19:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:19:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:19:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:39 INFO - (blobuploader) - INFO - Done attempting. 03:19:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:19:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:19:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:19:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:19:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:19:40 INFO - (blobuploader) - INFO - Done attempting. 03:19:40 INFO - (blobuploader) - INFO - Iteration through files over. 03:19:40 INFO - Return code: 0 03:19:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:19:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:19:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3033213b40b4621e159c35b3219fc282e1e53a2a7e01e6db4d38b62a0217eaffb6e00d931551382323806f8c12d72832f800790e3bea45a10d107a76138994fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a564619d4446e24e76652d2656cdc7bb7c3445d59837f81fc20444001dfa813b43f3924bacbb236d9d2c3d2c347696f8ae80015f8b1d846d7a35fc056bf47937", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5bef1129b707098a8b0932bb74835d61b4afa16e8d6f468d21b6a38705582f17e02c48f0b9be2bc5abb64ad9c524000f7046ed4c0319c6741f345fa3c607119", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fee8767de7647d6695feab1e071782eecb306d06895d6ab9a8cef607d00b5fec226ea1c7ba564dc4d4ded640f2f6aaa3fd8ff5764b2cc4c6af30d684b58fb0ce"} 03:19:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:19:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:19:40 INFO - Contents: 03:19:40 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3033213b40b4621e159c35b3219fc282e1e53a2a7e01e6db4d38b62a0217eaffb6e00d931551382323806f8c12d72832f800790e3bea45a10d107a76138994fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a564619d4446e24e76652d2656cdc7bb7c3445d59837f81fc20444001dfa813b43f3924bacbb236d9d2c3d2c347696f8ae80015f8b1d846d7a35fc056bf47937", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5bef1129b707098a8b0932bb74835d61b4afa16e8d6f468d21b6a38705582f17e02c48f0b9be2bc5abb64ad9c524000f7046ed4c0319c6741f345fa3c607119", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fee8767de7647d6695feab1e071782eecb306d06895d6ab9a8cef607d00b5fec226ea1c7ba564dc4d4ded640f2f6aaa3fd8ff5764b2cc4c6af30d684b58fb0ce"} 03:19:40 INFO - Running post-run listener: copy_logs_to_upload_dir 03:19:40 INFO - Copying logs to upload dir... 03:19:40 INFO - mkdir: /builds/slave/test/build/upload/logs 03:19:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.013853 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-09-15 03:19:41.524240) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 03:19:41.531318) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535 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/3033213b40b4621e159c35b3219fc282e1e53a2a7e01e6db4d38b62a0217eaffb6e00d931551382323806f8c12d72832f800790e3bea45a10d107a76138994fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a564619d4446e24e76652d2656cdc7bb7c3445d59837f81fc20444001dfa813b43f3924bacbb236d9d2c3d2c347696f8ae80015f8b1d846d7a35fc056bf47937", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5bef1129b707098a8b0932bb74835d61b4afa16e8d6f468d21b6a38705582f17e02c48f0b9be2bc5abb64ad9c524000f7046ed4c0319c6741f345fa3c607119", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fee8767de7647d6695feab1e071782eecb306d06895d6ab9a8cef607d00b5fec226ea1c7ba564dc4d4ded640f2f6aaa3fd8ff5764b2cc4c6af30d684b58fb0ce"} build_url:https://queue.taskcluster.net/v1/task/VYH2wZ13SaWnxkKe49_76g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011683 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/3033213b40b4621e159c35b3219fc282e1e53a2a7e01e6db4d38b62a0217eaffb6e00d931551382323806f8c12d72832f800790e3bea45a10d107a76138994fa", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a564619d4446e24e76652d2656cdc7bb7c3445d59837f81fc20444001dfa813b43f3924bacbb236d9d2c3d2c347696f8ae80015f8b1d846d7a35fc056bf47937", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b5bef1129b707098a8b0932bb74835d61b4afa16e8d6f468d21b6a38705582f17e02c48f0b9be2bc5abb64ad9c524000f7046ed4c0319c6741f345fa3c607119", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fee8767de7647d6695feab1e071782eecb306d06895d6ab9a8cef607d00b5fec226ea1c7ba564dc4d4ded640f2f6aaa3fd8ff5764b2cc4c6af30d684b58fb0ce"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-15 03:19:41.562777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:19:41.563235) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505469440.591311-2044924535 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-15 03:19:41.642741) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 03:19:41.646077) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-15 03:19:41.646390) ========= ========= Total master_lag: 0.54 =========