builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1504186239.18 results: success (0) revision: fb22415719a9d971a2646fa2d1b74e134ca00c3d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 06:30:39.184969) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-31 06:30:39.185443) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 06:30:39.185728) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-31 06:30:39.202056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:30:39.202446) ========= 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=923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-31 06:30:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.5M=0s 2017-08-31 06:30:39 (39.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093762 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:30:39.314905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:30:39.315286) ========= 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=923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024057 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:30:39.368776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-31 06:30:39.369232) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fb22415719a9d971a2646fa2d1b74e134ca00c3d --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 fb22415719a9d971a2646fa2d1b74e134ca00c3d --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=923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-31 06:30:39,823 truncating revision to first 12 chars 2017-08-31 06:30:39,823 Setting DEBUG logging. 2017-08-31 06:30:39,823 attempt 1/10 2017-08-31 06:30:39,823 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fb22415719a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-31 06:30:40,978 unpacking tar archive at: mozilla-central-fb22415719a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.498847 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-31 06:30:40.884719) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 06:30:40.885073) ========= script_repo_revision: fb22415719a9d971a2646fa2d1b74e134ca00c3d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-31 06:30:40.885460) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 06:30:40.885733) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-31 06:30:40.897162) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2017-08-31 06:30:40.897554) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:30:41 INFO - MultiFileLogger online at 20170831 06:30:41 in /builds/slave/test 06:30:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:30:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:30:41 INFO - {'append_to_log': False, 06:30:41 INFO - 'base_work_dir': '/builds/slave/test', 06:30:41 INFO - 'blob_upload_branch': 'Firefox', 06:30:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:30:41 INFO - 'branch': 'Firefox', 06:30:41 INFO - 'buildbot_json_path': 'buildprops.json', 06:30:41 INFO - 'code_coverage': False, 06:30:41 INFO - 'config_files': ('talos/linux_config.py',), 06:30:41 INFO - 'default_actions': ('clobber', 06:30:41 INFO - 'read-buildbot-config', 06:30:41 INFO - 'download-and-extract', 06:30:41 INFO - 'populate-webroot', 06:30:41 INFO - 'create-virtualenv', 06:30:41 INFO - 'install', 06:30:41 INFO - 'setup-mitmproxy', 06:30:41 INFO - 'run-tests'), 06:30:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:30:41 INFO - 'disable_ccov_upload': False, 06:30:41 INFO - 'disable_stylo': False, 06:30:41 INFO - 'download_minidump_stackwalk': True, 06:30:41 INFO - 'download_symbols': 'ondemand', 06:30:41 INFO - 'enable_stylo': False, 06:30:41 INFO - 'enable_webrender': False, 06:30:41 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 06:30:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:30:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:30:41 INFO - 'gecko_profile': False, 06:30:41 INFO - 'gecko_profile_interval': 0, 06:30:41 INFO - 'installer_path': 'installer.exe', 06:30:41 INFO - 'log_level': 'info', 06:30:41 INFO - 'log_name': 'talos', 06:30:41 INFO - 'log_to_console': True, 06:30:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:30:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:30:41 INFO - 'opt_config_files': (), 06:30:41 INFO - 'pip_index': False, 06:30:41 INFO - 'suite': 'dromaeojs-e10s', 06:30:41 INFO - 'system_bits': '32', 06:30:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:30:41 INFO - 'title': 'talos-linux64-ix-007', 06:30:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:30:41 INFO - 'use_talos_json': True, 06:30:41 INFO - 'verify': 'False', 06:30:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:30:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:30:41 INFO - 'work_dir': 'build'} 06:30:41 INFO - [mozharness: 2017-08-31 13:30:41.498079Z] Running clobber step. 06:30:41 INFO - Running pre-action listener: _resource_record_pre_action 06:30:41 INFO - Running main action method: clobber 06:30:41 INFO - rmtree: /builds/slave/test/build 06:30:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:30:43 INFO - Running post-action listener: _resource_record_post_action 06:30:43 INFO - [mozharness: 2017-08-31 13:30:43.059130Z] Finished clobber step (success) 06:30:43 INFO - [mozharness: 2017-08-31 13:30:43.059227Z] Running read-buildbot-config step. 06:30:43 INFO - Running pre-action listener: _resource_record_pre_action 06:30:43 INFO - Running main action method: read_buildbot_config 06:30:43 INFO - Using buildbot properties: 06:30:43 INFO - { 06:30:43 INFO - "project": "", 06:30:43 INFO - "product": "firefox", 06:30:43 INFO - "who": "archaeopteryx@coole-files.de", 06:30:43 INFO - "installer_path": "public/build/target.tar.bz2", 06:30:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 06:30:43 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:30:43 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 06:30:43 INFO - "stage_platform": "linux64-stylo", 06:30:43 INFO - "basedir": "/builds/slave/test", 06:30:43 INFO - "buildnumber": 67, 06:30:43 INFO - "platform": "ubuntu64_hw_stylo", 06:30:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:30:43 INFO - "slavebuilddir": "test", 06:30:43 INFO - "taskId": "WryvME65TiOROr_m8wbY-Q", 06:30:43 INFO - "branch": "mozilla-central", 06:30:43 INFO - "script_repo_revision": "production", 06:30:43 INFO - "revision": "fb22415719a9d971a2646fa2d1b74e134ca00c3d", 06:30:43 INFO - "slavename": "talos-linux64-ix-007", 06:30:43 INFO - "repo_path": "mozilla-central" 06:30:43 INFO - } 06:30:43 INFO - Finding installer, test and symbols from parent task. 06:30:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WryvME65TiOROr_m8wbY-Q'}, attempt #1 06:30:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WryvME65TiOROr_m8wbY-Q'}, attempt #1 06:30:44 INFO - Task dependencies: RI4nAJyITZ2MQzniRVqbBQ 06:30:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ'}, attempt #1 06:30:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2 06:30:44 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.test_packages.json 06:30:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.crashreporter-symbols.zip 06:30:44 INFO - Running post-action listener: _resource_record_post_action 06:30:44 INFO - [mozharness: 2017-08-31 13:30:44.694713Z] Finished read-buildbot-config step (success) 06:30:44 INFO - [mozharness: 2017-08-31 13:30:44.694928Z] Running download-and-extract step. 06:30:44 INFO - Running pre-action listener: _resource_record_pre_action 06:30:44 INFO - Running main action method: download_and_extract 06:30:44 INFO - mkdir: /builds/slave/test/build/tests 06:30:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:44 INFO - trying https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.test_packages.json 06:30:44 INFO - Downloading https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:30:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:30:45 INFO - Downloaded 989 bytes. 06:30:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:30:45 INFO - Using the following test package requirements: 06:30:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:30:45 INFO - u'common': [u'target.common.tests.zip'], 06:30:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:30:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:30:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:30:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:30:45 INFO - u'mozbase': [u'target.common.tests.zip'], 06:30:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:30:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:30:45 INFO - u'web-platform': [u'target.common.tests.zip', 06:30:45 INFO - u'target.web-platform.tests.tar.gz'], 06:30:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:30:45 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:30:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip 06:30:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:30:45 INFO - Fetch https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip into memory 06:31:16 INFO - retry: attempt #1 caught SSLError exception: The read operation timed out 06:31:16 INFO - retry: Failed, sleeping 30 seconds before retrying 06:31:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip'}, attempt #2 06:31:46 INFO - Fetch https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip into memory 06:31:48 INFO - Content-Length response header: 54932979 06:31:48 INFO - Bytes received: 54932979 06:31:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:31:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip 06:31:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:31:58 INFO - Fetch https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.common.tests.zip into memory 06:31:59 INFO - Content-Length response header: 54932979 06:31:59 INFO - Bytes received: 54932979 06:32:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.talos.tests.zip 06:32:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:32:11 INFO - Fetch https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.talos.tests.zip into memory 06:32:12 INFO - Content-Length response header: 14496650 06:32:12 INFO - Bytes received: 14496650 06:32:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:12 INFO - trying https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2 06:32:12 INFO - Downloading https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:32:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:32:13 INFO - Downloaded 62671715 bytes. 06:32:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2 06:32:13 INFO - mkdir: /builds/slave/test/properties 06:32:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:32:13 INFO - Writing to file /builds/slave/test/properties/build_url 06:32:13 INFO - Contents: 06:32:13 INFO - build_url:https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2 06:32:13 INFO - Running post-action listener: _resource_record_post_action 06:32:13 INFO - Running post-action listener: find_tests_for_verification 06:32:13 INFO - Running post-action listener: set_extra_try_arguments 06:32:13 INFO - [mozharness: 2017-08-31 13:32:13.909457Z] Finished download-and-extract step (success) 06:32:13 INFO - [mozharness: 2017-08-31 13:32:13.909556Z] Running populate-webroot step. 06:32:13 INFO - Running pre-action listener: _resource_record_pre_action 06:32:13 INFO - Running main action method: populate_webroot 06:32:13 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:32:13 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:32:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:32:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:32:13 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:32:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:32:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:32:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:32:13 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:32:13 INFO - 'talos_options': ['--enable-stylo'], 06:32:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:32:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:32:13 INFO - 'tests': ['damp', 'tps']}, 06:32:13 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:32:13 INFO - 'talos_options': ['--enable-stylo'], 06:32:13 INFO - 'tests': ['damp', 'tps']}, 06:32:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:32:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:32:13 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:32:13 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:32:13 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:32:13 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:32:13 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:32:13 INFO - 'talos_options': ['--enable-stylo'], 06:32:13 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:32:13 INFO - 'other-e10s': {'tests': ['a11yr', 06:32:13 INFO - 'ts_paint', 06:32:13 INFO - 'tpaint', 06:32:13 INFO - 'sessionrestore', 06:32:13 INFO - 'sessionrestore_many_windows', 06:32:13 INFO - 'sessionrestore_no_auto_restore', 06:32:13 INFO - 'tabpaint']}, 06:32:13 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:32:13 INFO - 'tests': ['a11yr', 06:32:13 INFO - 'ts_paint', 06:32:13 INFO - 'tpaint', 06:32:13 INFO - 'sessionrestore', 06:32:13 INFO - 'sessionrestore_many_windows', 06:32:13 INFO - 'sessionrestore_no_auto_restore', 06:32:13 INFO - 'tabpaint']}, 06:32:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:32:13 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 06:32:13 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:32:13 INFO - 'tests': ['bloom_basic_singleton']}, 06:32:13 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:32:13 INFO - 'tests': ['bloom_basic']}, 06:32:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:32:13 INFO - 'tsvgr_opacity', 06:32:13 INFO - 'tart', 06:32:13 INFO - 'tscrollx', 06:32:13 INFO - 'tsvg_static']}, 06:32:13 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 06:32:13 INFO - 'tests': ['tsvgx', 06:32:13 INFO - 'tsvgr_opacity', 06:32:13 INFO - 'tart', 06:32:13 INFO - 'tscrollx', 06:32:13 INFO - 'tsvg_static']}, 06:32:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:32:13 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:32:13 INFO - 'talos_options': ['--enable-stylo'], 06:32:13 INFO - 'tests': ['tp5o']}, 06:32:13 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:32:13 INFO - 'talos_options': ['--mitmproxy', 06:32:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:32:13 INFO - '--firstNonBlankPaint'], 06:32:13 INFO - 'tests': ['tp6_google', 06:32:13 INFO - 'tp6_youtube', 06:32:13 INFO - 'tp6_amazon', 06:32:13 INFO - 'tp6_facebook']}, 06:32:13 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:32:13 INFO - 'talos_options': ['--enable-stylo', 06:32:13 INFO - '--mitmproxy', 06:32:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:32:13 INFO - '--firstNonBlankPaint'], 06:32:13 INFO - 'tests': ['tp6_google', 06:32:13 INFO - 'tp6_youtube', 06:32:13 INFO - 'tp6_amazon', 06:32:13 INFO - 'tp6_facebook']}, 06:32:13 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:32:13 INFO - 'talos_options': ['--enable-stylo', 06:32:13 INFO - '--stylo-threads=1', 06:32:13 INFO - '--mitmproxy', 06:32:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:32:13 INFO - '--firstNonBlankPaint'], 06:32:13 INFO - 'tests': ['tp6_google', 06:32:13 INFO - 'tp6_youtube', 06:32:13 INFO - 'tp6_amazon', 06:32:13 INFO - 'tp6_facebook']}, 06:32:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:32:13 INFO - 'talos_options': ['--xperf_path', 06:32:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:32:13 INFO - 'tests': ['tp5n']}, 06:32:13 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 06:32:13 INFO - 'talos_options': ['--enable-stylo', 06:32:13 INFO - '--xperf_path', 06:32:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:32:13 INFO - 'tests': ['tp5n']}}} 06:32:13 INFO - Running post-action listener: _resource_record_post_action 06:32:13 INFO - [mozharness: 2017-08-31 13:32:13.923851Z] Finished populate-webroot step (success) 06:32:13 INFO - [mozharness: 2017-08-31 13:32:13.923939Z] Running create-virtualenv step. 06:32:13 INFO - Running pre-action listener: _resource_record_pre_action 06:32:13 INFO - Running main action method: create_virtualenv 06:32:13 INFO - Creating virtualenv /builds/slave/test/build/venv 06:32:13 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:32:13 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 06:32:13 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:32:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:32:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:32:14 INFO - Installing distribute.............................................................................................................................................................................................done. 06:32:14 INFO - Installing pip...............done. 06:32:14 INFO - Return code: 0 06:32:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:32:14 INFO - Reading from file tmpfile_stdout 06:32:14 INFO - Output received: 06:32:14 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 06:32:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:14 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 0x1bf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f60b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d580>, '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 0x1f5e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e910>, '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': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', '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 06:32:14 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 06:32:14 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 06:32:14 INFO - Using env: {'DISPLAY': ':0', 06:32:14 INFO - 'HOME': '/home/cltbld', 06:32:14 INFO - 'LANG': 'en_US.UTF-8', 06:32:14 INFO - 'LANGUAGE': 'en_US:en', 06:32:14 INFO - 'LOGNAME': 'cltbld', 06:32:14 INFO - 'MAIL': '/var/mail/cltbld', 06:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:14 INFO - 'MOZ_NO_REMOTE': '1', 06:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:14 INFO - 'NO_EM_RESTART': '1', 06:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:14 INFO - 'PWD': '/builds/slave/test', 06:32:14 INFO - 'SHELL': '/bin/bash', 06:32:14 INFO - 'SHLVL': '1', 06:32:14 INFO - 'TERM': 'linux', 06:32:14 INFO - 'TMOUT': '86400', 06:32:14 INFO - 'USER': 'cltbld', 06:32:14 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', 06:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:14 INFO - '_': '/tools/buildbot/bin/python'} 06:32:16 INFO - Ignoring indexes: http://pypi.python.org/simple/ 06:32:16 INFO - Downloading/unpacking pip>=1.5 06:32:16 INFO - Running setup.py egg_info for package pip 06:32:16 INFO - warning: no files found matching 'pip/cacert.pem' 06:32:16 INFO - warning: no files found matching '*.html' under directory 'docs' 06:32:16 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:32:16 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:32:16 INFO - Installing collected packages: pip 06:32:16 INFO - Found existing installation: pip 1.1 06:32:16 INFO - Uninstalling pip: 06:32:16 INFO - Successfully uninstalled pip 06:32:16 INFO - Running setup.py install for pip 06:32:16 INFO - warning: no files found matching 'pip/cacert.pem' 06:32:16 INFO - warning: no files found matching '*.html' under directory 'docs' 06:32:16 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:32:16 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:32:16 INFO - Installing pip script to /builds/slave/test/build/venv/bin 06:32:16 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 06:32:16 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 06:32:16 INFO - Successfully installed pip 06:32:16 INFO - Cleaning up... 06:32:16 INFO - Return code: 0 06:32:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:32: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')]} 06:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32: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')]} 06:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32: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', '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 0x1bf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f60b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d580>, '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 0x1f5e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e910>, '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': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', '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 06:32: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:32: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 psutil>=3.1.1 06:32:16 INFO - Using env: {'DISPLAY': ':0', 06:32:16 INFO - 'HOME': '/home/cltbld', 06:32:16 INFO - 'LANG': 'en_US.UTF-8', 06:32:16 INFO - 'LANGUAGE': 'en_US:en', 06:32:16 INFO - 'LOGNAME': 'cltbld', 06:32:16 INFO - 'MAIL': '/var/mail/cltbld', 06:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:16 INFO - 'MOZ_NO_REMOTE': '1', 06:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:16 INFO - 'NO_EM_RESTART': '1', 06:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:16 INFO - 'PWD': '/builds/slave/test', 06:32:16 INFO - 'SHELL': '/bin/bash', 06:32:16 INFO - 'SHLVL': '1', 06:32:16 INFO - 'TERM': 'linux', 06:32:16 INFO - 'TMOUT': '86400', 06:32:16 INFO - 'USER': 'cltbld', 06:32:16 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', 06:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:16 INFO - '_': '/tools/buildbot/bin/python'} 06:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:16 INFO - Downloading/unpacking psutil>=3.1.1 06:32:16 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 06:32:16 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 06:32:16 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 06:32:16 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 06:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:32:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:32:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:32:17 INFO - Installing collected packages: psutil 06:32:17 INFO - Running setup.py install for psutil 06:32:17 INFO - building 'psutil._psutil_linux' extension 06:32:17 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 06:32:17 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 06:32:17 INFO - building 'psutil._psutil_posix' extension 06:32:17 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 06:32:17 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 06:32:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:32:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:32:18 INFO - Successfully installed psutil 06:32:18 INFO - Cleaning up... 06:32:18 INFO - Return code: 0 06:32:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f60b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d580>, '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 0x1f5e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e910>, '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': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', '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 06:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:32:18 INFO - Using env: {'DISPLAY': ':0', 06:32:18 INFO - 'HOME': '/home/cltbld', 06:32:18 INFO - 'LANG': 'en_US.UTF-8', 06:32:18 INFO - 'LANGUAGE': 'en_US:en', 06:32:18 INFO - 'LOGNAME': 'cltbld', 06:32:18 INFO - 'MAIL': '/var/mail/cltbld', 06:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:18 INFO - 'MOZ_NO_REMOTE': '1', 06:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:18 INFO - 'NO_EM_RESTART': '1', 06:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:18 INFO - 'PWD': '/builds/slave/test', 06:32:18 INFO - 'SHELL': '/bin/bash', 06:32:18 INFO - 'SHLVL': '1', 06:32:18 INFO - 'TERM': 'linux', 06:32:18 INFO - 'TMOUT': '86400', 06:32:18 INFO - 'USER': 'cltbld', 06:32:18 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', 06:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:18 INFO - '_': '/tools/buildbot/bin/python'} 06:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:32:19 INFO - Installing collected packages: mozsystemmonitor 06:32:19 INFO - Running setup.py install for mozsystemmonitor 06:32:19 INFO - Successfully installed mozsystemmonitor 06:32:19 INFO - Cleaning up... 06:32:19 INFO - Return code: 0 06:32:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:32: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')]} 06:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32: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')]} 06:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32: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', '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 0x1bf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f60b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d580>, '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 0x1f5e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e910>, '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': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', '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 06:32: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:32: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 jsonschema==2.5.1 06:32:19 INFO - Using env: {'DISPLAY': ':0', 06:32:19 INFO - 'HOME': '/home/cltbld', 06:32:19 INFO - 'LANG': 'en_US.UTF-8', 06:32:19 INFO - 'LANGUAGE': 'en_US:en', 06:32:19 INFO - 'LOGNAME': 'cltbld', 06:32:19 INFO - 'MAIL': '/var/mail/cltbld', 06:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:19 INFO - 'MOZ_NO_REMOTE': '1', 06:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:19 INFO - 'NO_EM_RESTART': '1', 06:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:19 INFO - 'PWD': '/builds/slave/test', 06:32:19 INFO - 'SHELL': '/bin/bash', 06:32:19 INFO - 'SHLVL': '1', 06:32:19 INFO - 'TERM': 'linux', 06:32:19 INFO - 'TMOUT': '86400', 06:32:19 INFO - 'USER': 'cltbld', 06:32:19 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', 06:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:19 INFO - '_': '/tools/buildbot/bin/python'} 06:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:19 INFO - Downloading/unpacking jsonschema==2.5.1 06:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:32:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:32: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 06:32: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 06:32: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 06:32: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 06:32:20 INFO - Downloading functools32-3.2.3-2.tar.gz 06:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:32:21 INFO - warning: no files found matching '*.txt' 06:32:21 INFO - no previously-included directories found matching 'build' 06:32:21 INFO - no previously-included directories found matching 'dist' 06:32:21 INFO - no previously-included directories found matching '.git*' 06:32:21 INFO - Installing collected packages: jsonschema, functools32 06:32:21 INFO - Running setup.py install for functools32 06:32:21 INFO - warning: no files found matching '*.txt' 06:32:21 INFO - no previously-included directories found matching 'build' 06:32:21 INFO - no previously-included directories found matching 'dist' 06:32:21 INFO - no previously-included directories found matching '.git*' 06:32:21 INFO - Successfully installed jsonschema functools32 06:32:21 INFO - Cleaning up... 06:32:21 INFO - Return code: 0 06:32:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:32:21 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')]} 06:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:21 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')]} 06:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:21 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 0x1bf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f60b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d580>, '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 0x1f5e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e910>, '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': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', '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 06:32:21 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 06:32:21 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 06:32:21 INFO - Using env: {'DISPLAY': ':0', 06:32:21 INFO - 'HOME': '/home/cltbld', 06:32:21 INFO - 'LANG': 'en_US.UTF-8', 06:32:21 INFO - 'LANGUAGE': 'en_US:en', 06:32:21 INFO - 'LOGNAME': 'cltbld', 06:32:21 INFO - 'MAIL': '/var/mail/cltbld', 06:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:21 INFO - 'MOZ_NO_REMOTE': '1', 06:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:21 INFO - 'NO_EM_RESTART': '1', 06:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:21 INFO - 'PWD': '/builds/slave/test', 06:32:21 INFO - 'SHELL': '/bin/bash', 06:32:21 INFO - 'SHLVL': '1', 06:32:21 INFO - 'TERM': 'linux', 06:32:21 INFO - 'TMOUT': '86400', 06:32:21 INFO - 'USER': 'cltbld', 06:32:21 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', 06:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:21 INFO - '_': '/tools/buildbot/bin/python'} 06:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:32:21 INFO - Cleaning up... 06:32:21 INFO - Return code: 0 06:32:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:32:21 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')]} 06:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:21 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')]} 06:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:21 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 0x1bf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f60b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d580>, '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 0x1f5e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e910>, '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': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', '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 06:32:21 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 06:32:21 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 06:32:21 INFO - Using env: {'DISPLAY': ':0', 06:32:21 INFO - 'HOME': '/home/cltbld', 06:32:21 INFO - 'LANG': 'en_US.UTF-8', 06:32:21 INFO - 'LANGUAGE': 'en_US:en', 06:32:21 INFO - 'LOGNAME': 'cltbld', 06:32:21 INFO - 'MAIL': '/var/mail/cltbld', 06:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:21 INFO - 'MOZ_NO_REMOTE': '1', 06:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:21 INFO - 'NO_EM_RESTART': '1', 06:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:21 INFO - 'PWD': '/builds/slave/test', 06:32:21 INFO - 'SHELL': '/bin/bash', 06:32:21 INFO - 'SHLVL': '1', 06:32:21 INFO - 'TERM': 'linux', 06:32:21 INFO - 'TMOUT': '86400', 06:32:21 INFO - 'USER': 'cltbld', 06:32:21 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', 06:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:21 INFO - '_': '/tools/buildbot/bin/python'} 06:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:21 INFO - Downloading/unpacking blobuploader==1.2.4 06:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:32:22 INFO - Downloading blobuploader-1.2.4.tar.gz 06:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:32:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:32: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 06:32: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 06:32: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 06:32: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 06:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:32:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:32:23 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 06:32:23 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 06:32:23 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 06:32:23 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 06:32:23 INFO - Downloading docopt-0.6.1.tar.gz 06:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:32:23 INFO - Installing collected packages: blobuploader, requests, docopt 06:32:23 INFO - Running setup.py install for blobuploader 06:32:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:32:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:32:23 INFO - Running setup.py install for requests 06:32:23 INFO - Running setup.py install for docopt 06:32:23 INFO - Successfully installed blobuploader requests docopt 06:32:23 INFO - Cleaning up... 06:32:23 INFO - Return code: 0 06:32:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:23 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 0x1bf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f60b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d580>, '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 0x1f5e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e910>, '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': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', '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 06:32:23 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 06:32:23 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 06:32:23 INFO - Using env: {'DISPLAY': ':0', 06:32:23 INFO - 'HOME': '/home/cltbld', 06:32:23 INFO - 'LANG': 'en_US.UTF-8', 06:32:23 INFO - 'LANGUAGE': 'en_US:en', 06:32:23 INFO - 'LOGNAME': 'cltbld', 06:32:23 INFO - 'MAIL': '/var/mail/cltbld', 06:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:23 INFO - 'MOZ_NO_REMOTE': '1', 06:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:23 INFO - 'NO_EM_RESTART': '1', 06:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:23 INFO - 'PWD': '/builds/slave/test', 06:32:23 INFO - 'SHELL': '/bin/bash', 06:32:23 INFO - 'SHLVL': '1', 06:32:23 INFO - 'TERM': 'linux', 06:32:23 INFO - 'TMOUT': '86400', 06:32:23 INFO - 'USER': 'cltbld', 06:32:23 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', 06:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:23 INFO - '_': '/tools/buildbot/bin/python'} 06:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:32:24 INFO - Running setup.py (path:/tmp/pip-OiSEku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:32:24 INFO - Running setup.py (path:/tmp/pip-5fRzB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:32:24 INFO - Running setup.py (path:/tmp/pip-hQUz0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:32:24 INFO - Running setup.py (path:/tmp/pip-IoWR5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:32:24 INFO - Running setup.py (path:/tmp/pip-0cjVyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:32:24 INFO - Running setup.py (path:/tmp/pip-Eml0SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:32:24 INFO - Running setup.py (path:/tmp/pip-YowOax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:32:24 INFO - Running setup.py (path:/tmp/pip-nj_8fK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:32:24 INFO - Running setup.py (path:/tmp/pip-cuNLfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:32:24 INFO - Running setup.py (path:/tmp/pip-5ULoVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:32:24 INFO - Running setup.py (path:/tmp/pip-uVffl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:32:24 INFO - Running setup.py (path:/tmp/pip-htlqTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:32:25 INFO - Running setup.py (path:/tmp/pip-uuJJJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:32:25 INFO - Running setup.py (path:/tmp/pip-8VkbBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:32:25 INFO - Running setup.py (path:/tmp/pip-Royd9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:32:25 INFO - Running setup.py (path:/tmp/pip-FtVdKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:32:25 INFO - Running setup.py (path:/tmp/pip-zOJW7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:32:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:32:25 INFO - Running setup.py install for manifestparser 06:32:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:32:25 INFO - Running setup.py install for mozcrash 06:32:25 INFO - Running setup.py install for mozdebug 06:32:25 INFO - Running setup.py install for mozdevice 06:32:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:32:25 INFO - Running setup.py install for mozfile 06:32:25 INFO - Running setup.py install for mozhttpd 06:32:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:32:25 INFO - Running setup.py install for mozinfo 06:32:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:32:26 INFO - Running setup.py install for mozInstall 06:32:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:32:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:32:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:32:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:32:26 INFO - Running setup.py install for mozleak 06:32:26 INFO - Running setup.py install for mozlog 06:32:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:32:26 INFO - Running setup.py install for moznetwork 06:32:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:32:26 INFO - Running setup.py install for mozprocess 06:32:26 INFO - Running setup.py install for mozprofile 06:32:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:32:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:32:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:32:26 INFO - Running setup.py install for mozrunner 06:32:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:32:26 INFO - Running setup.py install for mozscreenshot 06:32:26 INFO - Running setup.py install for moztest 06:32:27 INFO - Running setup.py install for mozversion 06:32:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:32:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:32:27 INFO - Cleaning up... 06:32:27 INFO - Return code: 0 06:32:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:27 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 0x1bf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f60b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d580>, '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 0x1f5e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e910>, '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': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', '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 06:32:27 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 06:32:27 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 06:32:27 INFO - Using env: {'DISPLAY': ':0', 06:32:27 INFO - 'HOME': '/home/cltbld', 06:32:27 INFO - 'LANG': 'en_US.UTF-8', 06:32:27 INFO - 'LANGUAGE': 'en_US:en', 06:32:27 INFO - 'LOGNAME': 'cltbld', 06:32:27 INFO - 'MAIL': '/var/mail/cltbld', 06:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:27 INFO - 'MOZ_NO_REMOTE': '1', 06:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:27 INFO - 'NO_EM_RESTART': '1', 06:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:27 INFO - 'PWD': '/builds/slave/test', 06:32:27 INFO - 'SHELL': '/bin/bash', 06:32:27 INFO - 'SHLVL': '1', 06:32:27 INFO - 'TERM': 'linux', 06:32:27 INFO - 'TMOUT': '86400', 06:32:27 INFO - 'USER': 'cltbld', 06:32:27 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', 06:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:27 INFO - '_': '/tools/buildbot/bin/python'} 06:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:32:27 INFO - Running setup.py (path:/tmp/pip-mWebY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:32:27 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)) 06:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:32:27 INFO - Running setup.py (path:/tmp/pip-mnrcwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:32:27 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)) 06:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:32:27 INFO - Running setup.py (path:/tmp/pip-PEkXEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:32:27 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)) 06:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:32:27 INFO - Running setup.py (path:/tmp/pip-IfLJby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:32:27 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)) 06:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:32:27 INFO - Running setup.py (path:/tmp/pip-iYU_2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:32:27 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)) 06:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:32:27 INFO - Running setup.py (path:/tmp/pip-sC_2WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:32:27 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)) 06:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:32:27 INFO - Running setup.py (path:/tmp/pip-wilSiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:32:27 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)) 06:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:32:27 INFO - Running setup.py (path:/tmp/pip-0mJzqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:32:27 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)) 06:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:32:27 INFO - Running setup.py (path:/tmp/pip-KNUw4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:32:28 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)) 06:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:32:28 INFO - Running setup.py (path:/tmp/pip-IAzIgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:32:28 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)) 06:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:32:28 INFO - Running setup.py (path:/tmp/pip-5yUcmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:32:28 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)) 06:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:32:28 INFO - Running setup.py (path:/tmp/pip-nb9AMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:32:28 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)) 06:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:32:28 INFO - Running setup.py (path:/tmp/pip-2YVua4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:32:28 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)) 06:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:32:28 INFO - Running setup.py (path:/tmp/pip-zsHUs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:32:28 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)) 06:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:32:28 INFO - Running setup.py (path:/tmp/pip-4TmO8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:32:28 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)) 06:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:32:28 INFO - Running setup.py (path:/tmp/pip-lzYmfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:32:28 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)) 06:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:32:28 INFO - Running setup.py (path:/tmp/pip-mzOVcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:32:28 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)) 06:32:28 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)) 06:32:28 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)) 06:32:28 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)) 06:32:28 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)) 06:32:28 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)) 06:32:28 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)) 06:32:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:32:28 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 06:32:28 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 06:32:28 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 06:32:28 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 06:32:29 INFO - Downloading blessings-1.6.tar.gz 06:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:32:29 INFO - Installing collected packages: blessings 06:32:29 INFO - Running setup.py install for blessings 06:32:29 INFO - Successfully installed blessings 06:32:29 INFO - Cleaning up... 06:32:29 INFO - Return code: 0 06:32:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:32:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:32:30 INFO - Reading from file tmpfile_stdout 06:32:30 INFO - Current package versions: 06:32:30 INFO - argparse == 1.2.1 06:32:30 INFO - blessings == 1.6 06:32:30 INFO - blobuploader == 1.2.4 06:32:30 INFO - docopt == 0.6.1 06:32:30 INFO - functools32 == 3.2.3-2 06:32:30 INFO - jsonschema == 2.5.1 06:32:30 INFO - manifestparser == 1.1 06:32:30 INFO - mozInstall == 1.13 06:32:30 INFO - mozcrash == 1.0 06:32:30 INFO - mozdebug == 0.1 06:32:30 INFO - mozdevice == 0.51 06:32:30 INFO - mozfile == 1.2 06:32:30 INFO - mozhttpd == 0.7 06:32:30 INFO - mozinfo == 0.10 06:32:30 INFO - mozleak == 0.1 06:32:30 INFO - mozlog == 3.5 06:32:30 INFO - moznetwork == 0.27 06:32:30 INFO - mozprocess == 0.25 06:32:30 INFO - mozprofile == 0.28 06:32:30 INFO - mozrunner == 6.13 06:32:30 INFO - mozscreenshot == 0.1 06:32:30 INFO - mozsystemmonitor == 0.3 06:32:30 INFO - moztest == 0.8 06:32:30 INFO - mozversion == 1.4 06:32:30 INFO - psutil == 3.1.1 06:32:30 INFO - requests == 1.2.3 06:32:30 INFO - wsgiref == 0.1.2 06:32:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:32:30 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')]} 06:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:30 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')]} 06:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:30 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 0x1bf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f60b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d580>, '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 0x1f5e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e910>, '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': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', '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 06:32:30 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 06:32:30 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 06:32:30 INFO - Using env: {'DISPLAY': ':0', 06:32:30 INFO - 'HOME': '/home/cltbld', 06:32:30 INFO - 'LANG': 'en_US.UTF-8', 06:32:30 INFO - 'LANGUAGE': 'en_US:en', 06:32:30 INFO - 'LOGNAME': 'cltbld', 06:32:30 INFO - 'MAIL': '/var/mail/cltbld', 06:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:30 INFO - 'MOZ_NO_REMOTE': '1', 06:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:30 INFO - 'NO_EM_RESTART': '1', 06:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:30 INFO - 'PWD': '/builds/slave/test', 06:32:30 INFO - 'SHELL': '/bin/bash', 06:32:30 INFO - 'SHLVL': '1', 06:32:30 INFO - 'TERM': 'linux', 06:32:30 INFO - 'TMOUT': '86400', 06:32:30 INFO - 'USER': 'cltbld', 06:32:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', 06:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:30 INFO - '_': '/tools/buildbot/bin/python'} 06:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:30 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)) 06:32:30 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)) 06:32:30 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)) 06:32:30 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)) 06:32:30 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)) 06:32:30 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)) 06:32:30 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)) 06:32:30 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)) 06:32:30 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)) 06:32:30 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:32:30 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 06:32:30 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 06:32:30 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 06:32:30 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 06:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:32:31 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)) 06:32:31 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)) 06:32:31 INFO - Installing collected packages: simplejson 06:32:31 INFO - Running setup.py install for simplejson 06:32:31 INFO - building 'simplejson._speedups' extension 06:32:31 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 06:32:32 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 06:32:32 INFO - Successfully installed simplejson 06:32:32 INFO - Cleaning up... 06:32:32 INFO - Return code: 0 06:32:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:32:32 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')]} 06:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:32:32 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')]} 06:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:32:32 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 0x1bf11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f60b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d580>, '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 0x1f5e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e910>, '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': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', '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 06:32:32 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 06:32:32 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 06:32:32 INFO - Using env: {'DISPLAY': ':0', 06:32:32 INFO - 'HOME': '/home/cltbld', 06:32:32 INFO - 'LANG': 'en_US.UTF-8', 06:32:32 INFO - 'LANGUAGE': 'en_US:en', 06:32:32 INFO - 'LOGNAME': 'cltbld', 06:32:32 INFO - 'MAIL': '/var/mail/cltbld', 06:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:32 INFO - 'MOZ_NO_REMOTE': '1', 06:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:32 INFO - 'NO_EM_RESTART': '1', 06:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:32 INFO - 'PWD': '/builds/slave/test', 06:32:32 INFO - 'SHELL': '/bin/bash', 06:32:32 INFO - 'SHLVL': '1', 06:32:32 INFO - 'TERM': 'linux', 06:32:32 INFO - 'TMOUT': '86400', 06:32:32 INFO - 'USER': 'cltbld', 06:32:32 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', 06:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:32 INFO - '_': '/tools/buildbot/bin/python'} 06:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:32:32 INFO - Cleaning up... 06:32:32 INFO - Return code: 0 06:32:32 INFO - Running post-action listener: _resource_record_post_action 06:32:32 INFO - Running post-action listener: _start_resource_monitoring 06:32:32 INFO - Starting resource monitoring. 06:32:32 INFO - [mozharness: 2017-08-31 13:32:32.836910Z] Finished create-virtualenv step (success) 06:32:32 INFO - [mozharness: 2017-08-31 13:32:32.837493Z] Running install step. 06:32:32 INFO - Running pre-action listener: _resource_record_pre_action 06:32:32 INFO - Running main action method: install 06:32:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:32:33 INFO - Reading from file tmpfile_stdout 06:32:33 INFO - Detecting whether we're running mozinstall >=1.0... 06:32:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:32:33 INFO - Reading from file tmpfile_stdout 06:32:33 INFO - Output received: 06:32:33 INFO - Usage: mozinstall [options] installer 06:32:33 INFO - Options: 06:32:33 INFO - -h, --help show this help message and exit 06:32:33 INFO - -d DEST, --destination=DEST 06:32:33 INFO - Directory to install application into. [default: 06:32:33 INFO - "/builds/slave/test"] 06:32:33 INFO - --app=APP Application being installed. [default: firefox] 06:32:33 INFO - mkdir: /builds/slave/test/build/application 06:32:33 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'] 06:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:32:49 INFO - Reading from file tmpfile_stdout 06:32:49 INFO - Output received: 06:32:49 INFO - /builds/slave/test/build/application/firefox/firefox 06:32:49 INFO - Running post-action listener: _resource_record_post_action 06:32:49 INFO - [mozharness: 2017-08-31 13:32:49.655906Z] Finished install step (success) 06:32:49 INFO - [mozharness: 2017-08-31 13:32:49.656187Z] Running setup-mitmproxy step. 06:32:49 INFO - Running pre-action listener: _resource_record_pre_action 06:32:49 INFO - Running main action method: setup_mitmproxy 06:32:49 INFO - Skipping: mitmproxy is not required 06:32:49 INFO - Running post-action listener: _resource_record_post_action 06:32:49 INFO - [mozharness: 2017-08-31 13:32:49.657311Z] Finished setup-mitmproxy step (success) 06:32:49 INFO - [mozharness: 2017-08-31 13:32:49.657567Z] Running run-tests step. 06:32:49 INFO - Running pre-action listener: _resource_record_pre_action 06:32:49 INFO - Running pre-action listener: _set_gcov_prefix 06:32:49 INFO - Running main action method: run_tests 06:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:32:49 INFO - Python 2.7.3 06:32:49 INFO - Return code: 0 06:32:49 INFO - grabbing minidump binary from tooltool 06:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:32:49 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 0x1f5d580>, '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 0x1f5e480>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5e910>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:32:49 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 06:32:49 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 06:32:49 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 06:32:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:32:49 INFO - Return code: 0 06:32:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:32:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:32:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:32:49 INFO - ENV: RUST_BACKTRACE is now full 06:32:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:32:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:32:49 INFO - Using env: {'DISPLAY': ':0', 06:32:49 INFO - 'HOME': '/home/cltbld', 06:32:49 INFO - 'LANG': 'en_US.UTF-8', 06:32:49 INFO - 'LANGUAGE': 'en_US:en', 06:32:49 INFO - 'LOGNAME': 'cltbld', 06:32:49 INFO - 'MAIL': '/var/mail/cltbld', 06:32:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:32:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:49 INFO - 'MOZ_NO_REMOTE': '1', 06:32:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:49 INFO - 'NO_EM_RESTART': '1', 06:32:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:49 INFO - 'PWD': '/builds/slave/test', 06:32:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:32:49 INFO - 'RUST_BACKTRACE': 'full', 06:32:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:32:49 INFO - 'SHELL': '/bin/bash', 06:32:49 INFO - 'SHLVL': '1', 06:32:49 INFO - 'STYLO_FORCE_ENABLED': '1', 06:32:49 INFO - 'TERM': 'linux', 06:32:49 INFO - 'TMOUT': '86400', 06:32:49 INFO - 'USER': 'cltbld', 06:32:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', 06:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:49 INFO - '_': '/tools/buildbot/bin/python'} 06:32:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:32:50 INFO - mozversion application_buildid: 20170831123711 06:32:50 INFO - mozversion application_changeset: fb22415719a9d971a2646fa2d1b74e134ca00c3d 06:32:50 INFO - mozversion application_display_name: Nightly 06:32:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:32:50 INFO - mozversion application_name: Firefox 06:32:50 INFO - mozversion application_remotingname: firefox 06:32:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:32:50 INFO - mozversion application_vendor: Mozilla 06:32:50 INFO - mozversion application_version: 57.0a1 06:32:50 INFO - mozversion platform_buildid: 20170831123711 06:32:50 INFO - mozversion platform_changeset: fb22415719a9d971a2646fa2d1b74e134ca00c3d 06:32:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:32:50 INFO - mozversion platform_version: 57.0a1 06:32:50 INFO - using testdate: 1504186370 06:32:50 INFO - actual date: 1504186370 06:32:50 INFO - starting webserver on 'localhost:40404' 06:32:50 INFO - SUITE-START | Running 2 tests 06:32:50 INFO - TEST-START | dromaeo_css 06:32:50 INFO - Initialising browser for dromaeo_css test... 06:32:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40404/getInfo.html -profile /tmp/tmpErjLUd/profile 06:32:50 INFO - TEST-INFO | started process 5880 (/builds/slave/test/build/application/firefox/firefox http://localhost:40404/getInfo.html) 06:32:55 INFO - TEST-INFO | 5880: exit 0 06:32:55 INFO - Browser initialized. 06:32:55 INFO - Running cycle 1/1 for dromaeo_css test... 06:32:55 INFO - Using env: {'DISPLAY': ':0', 06:32:55 INFO - 'HOME': '/home/cltbld', 06:32:55 INFO - 'JSGC_DISABLE_POISONING': '1', 06:32:55 INFO - 'LANG': 'en_US.UTF-8', 06:32:55 INFO - 'LANGUAGE': 'en_US:en', 06:32:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:32:55 INFO - 'LOGNAME': 'cltbld', 06:32:55 INFO - 'MAIL': '/var/mail/cltbld', 06:32:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:32:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:32:55 INFO - 'MOZ_CRASHREPORTER': '1', 06:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:32:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:32:55 INFO - 'MOZ_NO_REMOTE': '1', 06:32:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:32:55 INFO - 'NO_EM_RESTART': '1', 06:32:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:32:55 INFO - 'PWD': '/builds/slave/test', 06:32:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:32:55 INFO - 'RUST_BACKTRACE': 'full', 06:32:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:32:55 INFO - 'SHELL': '/bin/bash', 06:32:55 INFO - 'SHLVL': '1', 06:32:55 INFO - 'STYLO_FORCE_ENABLED': '1', 06:32:55 INFO - 'TERM': 'linux', 06:32:55 INFO - 'TMOUT': '86400', 06:32:55 INFO - 'USER': 'cltbld', 06:32:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', 06:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:32:55 INFO - '_': '/tools/buildbot/bin/python'} 06:32:55 INFO - TEST-INFO | started process 6079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpErjLUd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:32:56 INFO - PID 6079 | 06:32:56 INFO - PID 6079 | (/builds/slave/test/build/application/firefox/firefox:6130): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:32:56 INFO - PID 6079 | 06:33:07 INFO - PID 6079 | RSS: Main: 167374848 06:33:07 INFO - PID 6079 | 06:36:04 INFO - PID 6079 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40404/tests/dromaeo/cssquery-ext.html) 06:36:06 INFO - PID 6079 | RSS: Main: 173940736 06:36:06 INFO - PID 6079 | 06:39:08 INFO - PID 6079 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-ext.html (next: http://localhost:40404/tests/dromaeo/cssquery-jquery.html) 06:39:08 INFO - PID 6079 | RSS: Main: 170131456 06:39:08 INFO - PID 6079 | 06:42:10 INFO - PID 6079 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40404/tests/dromaeo/cssquery-mootools.html) 06:42:11 INFO - PID 6079 | RSS: Main: 172261376 06:42:11 INFO - PID 6079 | 06:45:12 INFO - PID 6079 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40404/tests/dromaeo/cssquery-prototype.html) 06:45:13 INFO - PID 6079 | RSS: Main: 170635264 06:45:13 INFO - PID 6079 | 06:48:17 INFO - PID 6079 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40404/tests/dromaeo/cssquery-yui.html) 06:48:17 INFO - PID 6079 | RSS: Main: 170741760 06:48:17 INFO - PID 6079 | 06:51:19 INFO - PID 6079 | Cycle 1(1): loaded http://localhost:40404/tests/dromaeo/cssquery-yui.html (next: http://localhost:40404/tests/dromaeo/cssquery-dojo.html) 06:51:19 INFO - PID 6079 | RSS: Main: 174784512 06:51:19 INFO - PID 6079 | 06:51:19 INFO - PID 6079 | __start_tp_report 06:51:19 INFO - PID 6079 | _x_x_mozilla_page_load 06:51:19 INFO - PID 6079 | _x_x_mozilla_page_load_details 06:51:19 INFO - PID 6079 | |i|pagename|runs| 06:51:19 INFO - PID 6079 | |0;dojo.html;3300.7029367356936;3306.9007929762115;3316.005198440468;3338.7829791063577;3346.4645656694934;6272;6283.434490895818;6293.779717709881;6322.304546499881;6364.172657554512;6054.727537260823;6177.505799536038;6187.35032821554;6194.938050619492;6199.721012554434;5746.1668058131445;5769.3076830780365;5777.248957635502;5784.56615753818;5819.185314056035;5692.829215123553;5817.301923769153;5818.650880947135;5824.679642619654;5850.795222167225;5856.355800861902;5862.443067908542;5894.204282421861;5922.2597175353085;5936.109583562457;5828.096645020008;5868;5879.441453061952;5924.052151655715;5936.079907614327;5172.120739474299;5589.944100559023;5702.429757024306;5733.770649174028;5819.7672093116225;6268.937310626927;6303.3066362700065;6321.525885558555;6333.398327158959;6411.230652321751;6636.8008959730805;6682.365175308387;6725.461963042945;6790.932090679079;6869.553479023847;6714.899276510856;6733.663316834188;6786.524943253974;6817.250102488722;6826.180858296986;6218.378162183745;6227.09707092469;6320.905186422253;6324.873502529969;6338.271098823649;6819.7272109116075;6864.656767161622;6872.862542749117;6909.619970901548;6913.274106218875;6614.603123812587;6642.036904648799;6657.800265991931;6663.600183988976;6700.49746269022;6680.131582894192;6714.764983225564;6768.153980752406;6806.727730890709;6814.250432452426;6615.569987950767;6661.666916654148;6708.731650733916;6710.127683401224;6785.796426107225;6739.831504212434;6771.153605799275;6804.6257455840405;6827.214870289881;6838.384545390939;5277.973610131925;5289.259503669489;5360.3299587551555;5362.544183744425;5373.032854086224;4534.229181039232;4564.680472366902;4601.746903920316;4615.892185875433;4646.233371493733;5920.822375328747;5937.228160339128;5952.791652292149;5954.702264886739;5959.195508606369;6750;6799.422049125781;6825;6867.931320686729;6891.931080689229;5795.565332600072;5822.883542329129;5888.558358123158;5924.763009479572;5945.316288626776;5703.828885133453;5776.220210271644;5788.479036886701;5868.471837534642;5901.40985901415;6517.283098859121;6555.475561955032;6589.110470086573;6627.37039981201;6637.933620663828;6742.797716068526;6750.8649827004165;6833.384995350442;6850.931490685129;6858.211305699909;6436.517261205522;6504.544681872224;6529.118568993125;6564.179477565304;6585.078089067631;6598.307177746459;6614.933850661432;6623.701933412912;6662.733490660319;6712.664366781739;6844.794656160323;6901.137357830271;6919.827004324932;6925.6190909500465;6928.099347084847;6506.9263571512065;6514.218293804774;6536.444402225674;6624;6624.006399040182;6467.870642587028;6526.477881769352;6551.44312733404;6561.671916404256;6614.735410583715;6461;6486.870262594816;6532.987386955029;6539.051837483634;6545.574537655038;6400.967995160181;6526.510511711545;6539.803805885831;6540.182477190351;6564.737410503717;6218.502519798315;6239.313675495601;6241.812745617639;6242.157308763441;6245.750169993149 06:51:19 INFO - PID 6079 | |1;ext.html;817.3257062923086;857.6183598298757;887.0287035695915;895.9910400895991;1148.9195756297052;30883.22791930203;41589.16821663565;42292.57707422925;42315.78842105785;42346.788266058626;41714;42363.152736945245;42396;42420.363694544605;42514.57485425145;7329.19378868324;7750.96124519378;7992.760217193464;7996.600169991506;8005.239502247277;7790.727324543642;7922.524648521078;7928.445008849383;7929.484583502082;7929.563873986928;7883.8423231535335;7949.046114466243;7963.163867793885;7971.123176450586;7989.960050199741;7898.644560994769;7929.603519823986;7929.841403171933;7929.96035019827;7931.127575966639;7861.764147075597;7933.325667318285;7933.563653999027;7938.44430889838;7939.404544659116;38364.61635383666;38695.8065209675;38736.22527549433;38737.41893871594;38801.80599097015;3529.2235708144167;3556.039869235318;3558.6085530591613;3574.6425357464304;3582.15819282471;31450.685493145003;31464.213394665087;31471.685283147333;31519.527207091913;31604.841975790205;5050.368703912011;5157.174852023658;5168.896622067575;5200.609954253446;5221.556167725748;189935;191042;191099;191330;191481.9999999986;48758.51241487611;48823.755881220364;48830.51169488331;48844;48967.265491017664;50471.24293135606;50561.49438505568;50588.49411505911;50645;50672.74663626732;12763.17039392455;15118.244087795567;15276.694466110615;15348.616284592974;15367.538973830802;10473.057424831803;11328;11515.884841151648;11536.365499897585;11590.594329198437;14272.286385680674;14348.49780257686;14390.208538530482;14451.566453006426;14574.344154513072;5784.681842498619;5785.09506083392;5853.912191317134;5880.705964701748;5903.704814759245;996.6412091647002;1012.4633944009687;1019.2304809868501;1034.715453250362;1036.828923227659;22678.319650410514;22682.206122785625;22968.885155574448;22999.655005174936;23168.65247021296;1133.070881876853;1133.5975728616222;1133.790248803974;1138.1748232531513;1139.2594813371375;12025.879741202476;12205.633830985085;12219.522296012736;12297.631071067703;12317.260964342167;223352;225247;226753;226981;227349;52280.47719522756;52548;52701.7364913173;52720;52924.735376322875;1424.7934049562962;1440.8415074341815;1441.4882716635652;1452.7239824433325;1456.774199999023;22470;22655.773442266025;22720;22751;22977;36858.8157059213;36906.8154659225;36934.8153259232;36952.81523592365;36984.26031479409;188285;188472;189440;189454;189963;33437.33125337431;35033.474497883064;35254.64745352514;35279.11802204965;35387;44528.33207501955;45709;45782.54217457916;45816;45989.540104599866;33648.49527257044;33652.3269534603;33673.66326336705;33755.83122084374;33801.49297760487;33111.17222069467;33367.33265334728;33403.16492087717;33656.49515257322;34428;33329.33341333208;33347.33305333831;33613.66386336106;33636.66363336335;33663;32858.835705821315;32934.34131317408;33071.50392744159;33188.17029574183;33369.83315083409;24323.513529729662;24707.752922470547;24830.130945416822;25358.74641253564;25369.74630253748 06:51:19 INFO - PID 6079 | |2;jquery.html;558.6842984770865;571.2858926342072;578.2020811280433;583.1427801132334;599.5713065158411;22089.226877059307;22654.88672556639;22887.19894803682;22907.541849163008;22908.427289317777;25256.116035938747;26069.348266293353;26070.305430147026;26113.216603501878;26113.869430652867;6614.272430032693;6787.117674702282;6788.5587436816695;6789.117414736102;6795;6096.908546371808;6662.100616416795;6662.333766623347;6702.631355275458;6724.193096828363;6631.171103612049;6632.568883022588;6633.038209459625;6634.568753031038;6636.369544893251;6660.733570657168;6661.367170118831;6661.533692641517;6662;6662.56693314933;6139.416755408229;6145.78489752861;6158.445739883387;6159.969200153971;6174.7530098796;27963.440731185263;28753.85623071892;28891.56662650062;28947.276318092216;29490.262743431587;2038.0523056778668;2096.3815674376096;2098.087332010565;2099.3911765588114;2101.2225476573767;19052.71420928687;19619.607607847905;19638.01809909513;19649.115789789495;19740.210391584318;2375.6674065630827;2426.1993542131054;2450.0812195426715;2469.3085935937966;2507.0723832182025;130211;133216.33391833075;133237.3338133303;133949.3302533491;133989;14097.295135243197;14348.49780257686;14707.117572945657;14781.92609036948;14839.183844888636;23152.305430837103;23275.76724232736;23278;23283.18508852182;23306.067757289857;9711.708648740549;9805.754856128511;9826.115649591571;9942.30403871722;10031.39811611291;9068.637254509746;9079.863802042975;9193.63225470987;9213.078692130868;9250.72247832566;7575.09882410559;8929.553522323858;9045.77385565366;9223.800905882192;9233.861492077624;2565;2592.131635901994;2601.323655849455;2658.86705664716;2718.7281271872653;979.7060881735451;984.242133557157;997.8154041502345;1005.9497025148713;1012.1093437774712;19725.802741972682;19863.801361986196;19965.731355809272;19967.900160499106;20267.493312667302;1043.4209013997304;1050.9474526273655;1056.1656291529605;1056.3714589819044;1058.6453538064682;10882.455877206108;10926.399048052433;10948.34309941406;10972.615958441416;11259.605913792979;449024;454976;511124;522691;523939;113149;116913;118919.40540297244;119613;120059;1230.8830661087181;1231.759806837658;1268.9428975696117;1277.163457935054;1280.5326055989683;20140;20831;20856.165753369696;20965;21435.46411339729;53537.46462535325;54276.72861635667;55055.72472137614;55223.44776552183;56233;69333.30666693268;69390.65304673444;70004;70679.64660176667;77241.2275877234;16151.919240403722;20899.268525601532;21046.158153674292;21581.46046348791;22234.221802236843;23782.88108559446;23794.286171414886;24081.638775418032;24381.26856194317;24449.38876528101;17920.551986199927;18928.52678683044;19090.904545477184;19632.705509417658;19650.21399144018;16238.918805405898;16704.33182672728;16767.74848377251;17261.482155535356;17337.82662173362;19617.215311387383;19915.402537923885;20013.899930500254;20162.29431969874;20191.394258172277;20905.581888362452;21029;21070.894645526674;21207.363779086652;21226;16900;17066.2320195589;17078.316867325666;18342;18667.346642867433 06:51:19 INFO - PID 6079 | |3;mootools.html;1343.429042656871;1402.782568701851;1411.9904268448058;1412.0821466047075;1416.9797745623148;14802.555923322305;15578.844211557895;15582.220888955564;15586.688266234683;16035.599110022255;15706.528804135865;15994.680106397866;16012.959157654745;16023.599410014725;16025.919870400632;2659.149072296861;2661.8802153903025;2722.2922040269573;2723.2511059458707;2836.1633318171084;2747.285705716518;2781.652293463317;2795.888164473419;2810.00244913056;2810.873510692024;2707.2690373599116;2733.7539621434066;2733.8906443742226;2747.285705716508;2764.04640399063;2608.660874086366;2641.7886569074526;2655.7078721340636;2662.480816240834;2672.759451649361;2621.855797931113;2629.4346715456077;2634.894604215829;2642.3394151462135;2642.445086531831;14796.334164962602;15108.244587770567;15108.924455377763;15141.091534507965;15162.469313573973;8081.919180808175;8421.410501264914;8435.198656127657;8438;8442.535660538668;5388.218708287315;5547.362053363874;5582.692951887645;5685.857853553653;5712.457316554921;1855.5361159710073;1871.7660292463443;1886.5566591850904;1914.5692219250695;1922.846172306212;26795.73204267952;26961.0563630272;27042.72957270422;27051;27079.458410831674;6750.797476075725;6778.254392016875;6804.149481314836;6925.342092501204;7016.36852683261;17573.20920558578;17581.38465153739;17582.560435988948;17603;17628.823711762718;7836.451448398558;8087.069986951458;8091.838163236703;8093.473924194908;8097;7418.332350088518;7472.738454154187;7509.3617042552;7578.280063394079;7624.085109786861;5200.739963001834;5346.144616861284;5375.784968601212;5410.810621628303;5412.323459567554;1478.2830327291256;1486.717523670499;1496.85779850914;1499.3702644889172;1500.197394393994;848.974530764078;864.1876635962176;888.1296329596902;891.2023738753779;904.2268860124631;7729.304362607392;7752.4573279869865;7792.883106753403;7798.883016754753;7830.021247344082;720.585663243637;738.1621859189859;739.7669734033763;747.0922828763079;763.7975936376864;5139.511746384088;5646.160610784706;5705.372409035002;5707.400722924116;5861.296644402613;21190.47023824417;22141.225057122923;22418.215362462237;22453.32640020802;22503;21085.262015829372;22071.11715531361;22099.33701988943;22105.336839894506;22177.445563861034;11285.605003824827;11321.886781132249;11525.76948461026;11555.537778488935;11561.88438115608;8606.65573377058;8630;8637.784055398413;8752.693655722274;8781.824363512565;18113.45659630213;18540.351087712406;18748.250069997048;18807;19040.61918761645;18946.621067578297;19119.13963871657;19153.233870645574;19180.904095479433;19359.903200483906;10662.680119596425;10821.242513024014;10823.67528974132;10835.837462438227;10838.945805271238;13283.800742989057;13411.597652070453;13535.59393218205;13546.93226533861;13553.661158471117;11065.668029959113;11102.167337449562;11133;11268.267562608404;11405;10118.392896426238;10147.949260253652;10212.744681383025;10274.229432792421;10383.480825958823;9432.481213533321;9564.904350956402;9629.566669499749;9652.951735241279;9665.3234273603;6941.34057264559;6967.965160174167;6977.581345119309;6978.371946524837;7081.398081163159;7213.567185968858;7221;7251.927480725125;7292.854142917218;7302.160251571137 06:51:19 INFO - PID 6079 | |4;prototype.html;499.87003379121415;501.3432403551348;521.6531006880425;522.699447817505;530.2814686100334;6193.411625895538;6300.306966233722;6300.684965751711;6398.936010639893;6420.903686444707;5962.195103661015;6063.484603808682;6113.32753397126;6154.876902461948;6182.732539829324;4959.231319145538;4979.203327467606;4994.525520075587;5040.747962601855;5063.265826455171;5006.749662516878;5015.5736762375245;5022.82420115296;5058.494150584949;5110.9744451277875;4812.711237325754;4868.97565512172;4987.251912213161;5005.499450054984;5006;4988.152014157584;5011.473795251519;5022.8196373852115;5027.371578552681;5057.418396884369;4484.1928452878465;4498.8875278117985;4500.324951257305;4508.61676757476;4550.863474095782;6176.054542819043;6182.732539829324;6204.565680402374;6224.159738435299;6230.096635987802;5550.639208451437;5655.745491452894;5701.6864072476;5751.597388182829;5765.567582431292;6468.159139311906;6488.610683359014;6492.513061520358;6538.411542961157;6566.70449829754;4838.927416088762;4868.563773686736;4901.181820453254;4902.828401005983;4909.386326709161;6799.7280108796085;6901.965490172567;6939.167299924042;6985.126859142607;7002.258148318381;4958.8181200271765;5001.074801161797;5004.724740139327;5025.296458495741;5048.242763585492;5097.572679649704;5100.872478188001;5116.948830511647;5131.61512886535;5136.0241554104605;5637.548996080303;5653.858653533694;5701.629394089371;5718.4567466091485;5743.013632910863;6526.967365163144;6551.706902584057;6569.343065693392;6584.407403333723;6600.73597056122;1661.1860188507785;1679.638877641313;1722.922468488921;1732.1079643983358;1757.7627020352345;1185.8280549320473;1225.0934308611563;1227.9079069069676;1231.5566396097397;1247.2267194339386;5623.156526520973;5715.971420142956;5748.780682817552;5762.855928601818;5778.479936805624;6565.601047298322;6593.505487088488;6640.800775976729;6682.799516014527;6699.263081061079;5751.217122691979;5780.624259423124;5784.537237021028;5820.621659592113;5834.708264586839;3536.133647256387;3573.4282514797505;3581.982090089533;3585.1395665040723;3616.4575313703153;6549.770758023446;6594.373534514213;6599.472042236705;6643.734250629921;6680.594985805106;6950.687219075154;6973.8493148629905;6977.581345119309;7006.474514411338;7007.684654190573;6530.1510803596175;6553.967230163818;6611.702473388709;6634.767783127568;6636.170478690164;6720.193576770819;6728;6749.527533072835;6786.966065169642;6805.149356330458;6711.731530738911;6720.663966801738;6750.32496750321;6767.25560188369;6803.625800581016;6516.771912983023;6585.407313341822;6609.669516524058;6618.602883826986;6666.533342665967;4932.383452068491;5000.624953128603;5006.274090256965;5010.123228434936;5036.1942089267;6746.9325306746305;6783.423409010289;6797.980302954398;6798.252192258748;6850.760223392357;6499.772507962199;6511.186101737283;6528.474623703147;6539.574927629879;6542.182227221598;6282.623042617458;6414.807555773335;6532.902006469812;6542.934570654233;6578.736850525926;6071.848203794941;6347.936520634735;6432.421082102634;6455.741770329322;6477.77327793525;6382.20222472191;6554.573952693059;6573.901391479228;6585.275619681735;6604.7781160485465;6057.636541807506;6240.500759939103;6304.968475157778;6356.332585078685;6363.5863668861375 06:51:19 INFO - PID 6079 | |5;yui.html;889.9466032038079;901.1709227510686;918.3800934369308;918.5958178401505;920.102899672819;18889.622207555876;18955.715664265048;19731.901340493296;19781.208751649934;19806.504837379038;18743.250269989185;18794.06029698513;18962.905185474054;19050;19126.52183695408;948.9383190092622;949.3022628368144;960.6157536985227;964.1900803325206;986.4574484033752;1014.7666036811538;1015.6496008876926;1017.6133069433605;1017.8574999500075;1020.3061917895828;1037.9792404151913;1038.1176000399637;1038.4288641247322;1038.532660302863;1038.6209033702683;1046.9528871200814;1047.0681093826463;1047.6647472808704;1047.675220681591;1049.8582691336649;766.3677466090497;766.5898744171841;766.6626684258908;766.7814672818275;766.8427972265728;18961.810381896143;19041.619167616707;19241.13414896333;19398.22407103714;20534.383968480968;21054.157833686633;21486.785132148634;21559.568808623895;21567.460813479633;21637.45906352338;17089.316427342892;17138.914305428516;17192.57018574533;17200.741988870177;17245.310187592608;3751.5123034005405;3784.7729136251914;3786.734928555002;3788.1666033472593;3788.2802267569073;125995;129499.99999999905;129665.35167324104;131230.3438482811;134138;16867.493975180765;17315.91342043282;17316.82683173152;17575.560610984572;17618.823811761973;31213.531797023064;31456.213594660316;31578;31726.2068448286;31730;8677.652893884175;8693.565321733888;8842.513661748537;8862.556872156367;8864.512451815212;4184.205001049791;4232.047789247456;4296.398504209413;4302.118065796567;4309.956900431018;5035.521625445577;5134.409542902539;5139.383274007068;5144.6655967362;5169.870753231199;1004.322082594246;1067.6957067235955;1076.7146706122883;1078.6224821312478;1079.2553138334524;674.1000763980142;688.1295161620554;691.0463560286772;695.3624214973765;702.3292755418563;10537.84193237102;10833.512491937881;11339.319640821577;11946.641600751991;12465.5013799447;696.0799446322628;696.613379574331;701.8596280743769;715.0704084689883;715.3847690985748;5263.499967503081;5424.972875135599;5448.264484294648;5545.112781954948;5547.33431988164;112725;115987;116678;118965;120174;97145.5142724296;100355.49822250842;101181.49409252907;103843;104051.47974260231;86614;87358.126418735;89174.55412722896;89632;89894.55052724826;11402;11918.523259069887;12031.2101687968;12102.273863568214;12413.689657758629;38948;39026.41460378154;39509.604903950596;40876.38685419781;41077.38383924303;59881.700591498506;72447;73895.63052184919;75171.24828751643;75383;13628;13667.79498307546;13722.862771372558;13814.240216788174;13820.308984550933;19851.900740496207;20112.698309525076;20232;20727;20869.1652333911;16756.497305080866;16818;17231.913840431218;17278.481645550655;17399.043052632227;17947.01291428984;17993.280268789626;18179.363722269656;18357.908210459398;18541.44375668732;16524.66950661004;16990.745138823175;17950;18647.533811654816;18726;11626.593069242535;11786.823197651871;12178.269303841798;12418.813717794059;12639.241645501299;13677.110987785762;13769.682000617522;13822.203113595167;14146.717065658424;14662.486812961923 06:51:19 INFO - PID 6079 | __end_tp_report 06:51:19 INFO - PID 6079 | __start_cc_report 06:51:19 INFO - PID 6079 | _x_x_mozilla_cycle_collect,354 06:51:19 INFO - PID 6079 | __end_cc_report 06:51:19 INFO - PID 6079 | __startTimestamp1504187479630__endTimestamp 06:51:19 INFO - PID 6079 | 06:51:19 INFO - PID 6079 | ------- Summary: start ------- 06:51:19 INFO - PID 6079 | Number of tests: 6 06:51:19 INFO - PID 6079 | 06:51:19 INFO - PID 6079 | [#0] dojo.html Cycles:165 Average:6208.55 Median:6461.00 stddev:727.00 (11.3%) stddev-sans-first:692.51 06:51:19 INFO - PID 6079 | Values: 3300.7 3306.9 3316.0 3338.8 3346.5 6272.0 6283.4 6293.8 6322.3 6364.2 6054.7 6177.5 6187.4 6194.9 6199.7 5746.2 5769.3 5777.2 5784.6 5819.2 5692.8 5817.3 5818.7 5824.7 5850.8 5856.4 5862.4 5894.2 5922.3 5936.1 5828.1 5868.0 5879.4 5924.1 5936.1 5172.1 5589.9 5702.4 5733.8 5819.8 6268.9 6303.3 6321.5 6333.4 6411.2 6636.8 6682.4 6725.5 6790.9 6869.6 6714.9 6733.7 6786.5 6817.3 6826.2 6218.4 6227.1 6320.9 6324.9 6338.3 6819.7 6864.7 6872.9 6909.6 6913.3 6614.6 6642.0 6657.8 6663.6 6700.5 6680.1 6714.8 6768.2 6806.7 6814.3 6615.6 6661.7 6708.7 6710.1 6785.8 6739.8 6771.2 6804.6 6827.2 6838.4 5278.0 5289.3 5360.3 5362.5 5373.0 4534.2 4564.7 4601.7 4615.9 4646.2 5920.8 5937.2 5952.8 5954.7 5959.2 6750.0 6799.4 6825.0 6867.9 6891.9 5795.6 5822.9 5888.6 5924.8 5945.3 5703.8 5776.2 5788.5 5868.5 5901.4 6517.3 6555.5 6589.1 6627.4 6637.9 6742.8 6750.9 6833.4 6850.9 6858.2 6436.5 6504.5 6529.1 6564.2 6585.1 6598.3 6614.9 6623.7 6662.7 6712.7 6844.8 6901.1 6919.8 6925.6 6928.1 6506.9 6514.2 6536.4 6624.0 6624.0 6467.9 6526.5 6551.4 6561.7 6614.7 6461.0 6486.9 6533.0 6539.1 6545.6 6401.0 6526.5 6539.8 6540.2 6564.7 6218.5 6239.3 6241.8 6242.2 6245.8 06:51:19 INFO - PID 6079 | 06:51:19 INFO - PID 6079 | [#1] ext.html Cycles:180 Average:37320.11 Median:34114.75 stddev:52493.10 (153.9%) stddev-sans-first:52568.80 06:51:19 INFO - PID 6079 | Values: 817.3 857.6 887.0 896.0 1148.9 30883.2 41589.2 42292.6 42315.8 42346.8 41714.0 42363.2 42396.0 42420.4 42514.6 7329.2 7751.0 7992.8 7996.6 8005.2 7790.7 7922.5 7928.4 7929.5 7929.6 7883.8 7949.0 7963.2 7971.1 7990.0 7898.6 7929.6 7929.8 7930.0 7931.1 7861.8 7933.3 7933.6 7938.4 7939.4 38364.6 38695.8 38736.2 38737.4 38801.8 3529.2 3556.0 3558.6 3574.6 3582.2 31450.7 31464.2 31471.7 31519.5 31604.8 5050.4 5157.2 5168.9 5200.6 5221.6 189935.0 191042.0 191099.0 191330.0 191482.0 48758.5 48823.8 48830.5 48844.0 48967.3 50471.2 50561.5 50588.5 50645.0 50672.7 12763.2 15118.2 15276.7 15348.6 15367.5 10473.1 11328.0 11515.9 11536.4 11590.6 14272.3 14348.5 14390.2 14451.6 14574.3 5784.7 5785.1 5853.9 5880.7 5903.7 996.6 1012.5 1019.2 1034.7 1036.8 22678.3 22682.2 22968.9 22999.7 23168.7 1133.1 1133.6 1133.8 1138.2 1139.3 12025.9 12205.6 12219.5 12297.6 12317.3 223352.0 225247.0 226753.0 226981.0 227349.0 52280.5 52548.0 52701.7 52720.0 52924.7 1424.8 1440.8 1441.5 1452.7 1456.8 22470.0 22655.8 22720.0 22751.0 22977.0 36858.8 36906.8 36934.8 36952.8 36984.3 188285.0 188472.0 189440.0 189454.0 189963.0 33437.3 35033.5 35254.6 35279.1 35387.0 44528.3 45709.0 45782.5 45816.0 45989.5 33648.5 33652.3 33673.7 33755.8 33801.5 33111.2 33367.3 33403.2 33656.5 34428.0 33329.3 33347.3 33613.7 33636.7 33663.0 32858.8 32934.3 33071.5 33188.2 33369.8 24323.5 24707.8 24830.1 25358.7 25369.7 06:51:19 INFO - PID 6079 | 06:51:19 INFO - PID 6079 | [#2] jquery.html Cycles:180 Average:35180.21 Median:23280.59 stddev:82896.66 (356.1%) stddev-sans-first:83088.45 06:51:19 INFO - PID 6079 | Values: 558.7 571.3 578.2 583.1 599.6 22089.2 22654.9 22887.2 22907.5 22908.4 25256.1 26069.3 26070.3 26113.2 26113.9 6614.3 6787.1 6788.6 6789.1 6795.0 6096.9 6662.1 6662.3 6702.6 6724.2 6631.2 6632.6 6633.0 6634.6 6636.4 6660.7 6661.4 6661.5 6662.0 6662.6 6139.4 6145.8 6158.4 6160.0 6174.8 27963.4 28753.9 28891.6 28947.3 29490.3 2038.1 2096.4 2098.1 2099.4 2101.2 19052.7 19619.6 19638.0 19649.1 19740.2 2375.7 2426.2 2450.1 2469.3 2507.1 130211.0 133216.3 133237.3 133949.3 133989.0 14097.3 14348.5 14707.1 14781.9 14839.2 23152.3 23275.8 23278.0 23283.2 23306.1 9711.7 9805.8 9826.1 9942.3 10031.4 9068.6 9079.9 9193.6 9213.1 9250.7 7575.1 8929.6 9045.8 9223.8 9233.9 2565.0 2592.1 2601.3 2658.9 2718.7 979.7 984.2 997.8 1005.9 1012.1 19725.8 19863.8 19965.7 19967.9 20267.5 1043.4 1050.9 1056.2 1056.4 1058.6 10882.5 10926.4 10948.3 10972.6 11259.6 449024.0 454976.0 511124.0 522691.0 523939.0 113149.0 116913.0 118919.4 119613.0 120059.0 1230.9 1231.8 1268.9 1277.2 1280.5 20140.0 20831.0 20856.2 20965.0 21435.5 53537.5 54276.7 55055.7 55223.4 56233.0 69333.3 69390.7 70004.0 70679.6 77241.2 16151.9 20899.3 21046.2 21581.5 22234.2 23782.9 23794.3 24081.6 24381.3 24449.4 17920.6 18928.5 19090.9 19632.7 19650.2 16238.9 16704.3 16767.7 17261.5 17337.8 19617.2 19915.4 20013.9 20162.3 20191.4 20905.6 21029.0 21070.9 21207.4 21226.0 16900.0 17066.2 17078.3 18342.0 18667.3 06:51:19 INFO - PID 6079 | 06:51:19 INFO - PID 6079 | [#3] mootools.html Cycles:180 Average:9379.22 Median:2667.62 stddev:6772.93 (253.9%) stddev-sans-first:6765.02 06:51:19 INFO - PID 6079 | Values: 1343.4 1402.8 1412.0 1412.1 1417.0 14802.6 15578.8 15582.2 15586.7 16035.6 15706.5 15994.7 16013.0 16023.6 16025.9 2659.1 2661.9 2722.3 2723.3 2836.2 2747.3 2781.7 2795.9 2810.0 2810.9 2707.3 2733.8 2733.9 2747.3 2764.0 2608.7 2641.8 2655.7 2662.5 2672.8 2621.9 2629.4 2634.9 2642.3 2642.4 14796.3 15108.2 15108.9 15141.1 15162.5 8081.9 8421.4 8435.2 8438.0 8442.5 5388.2 5547.4 5582.7 5685.9 5712.5 1855.5 1871.8 1886.6 1914.6 1922.8 26795.7 26961.1 27042.7 27051.0 27079.5 6750.8 6778.3 6804.1 6925.3 7016.4 17573.2 17581.4 17582.6 17603.0 17628.8 7836.5 8087.1 8091.8 8093.5 8097.0 7418.3 7472.7 7509.4 7578.3 7624.1 5200.7 5346.1 5375.8 5410.8 5412.3 1478.3 1486.7 1496.9 1499.4 1500.2 849.0 864.2 888.1 891.2 904.2 7729.3 7752.5 7792.9 7798.9 7830.0 720.6 738.2 739.8 747.1 763.8 5139.5 5646.2 5705.4 5707.4 5861.3 21190.5 22141.2 22418.2 22453.3 22503.0 21085.3 22071.1 22099.3 22105.3 22177.4 11285.6 11321.9 11525.8 11555.5 11561.9 8606.7 8630.0 8637.8 8752.7 8781.8 18113.5 18540.4 18748.3 18807.0 19040.6 18946.6 19119.1 19153.2 19180.9 19359.9 10662.7 10821.2 10823.7 10835.8 10838.9 13283.8 13411.6 13535.6 13546.9 13553.7 11065.7 11102.2 11133.0 11268.3 11405.0 10118.4 10147.9 10212.7 10274.2 10383.5 9432.5 9564.9 9629.6 9653.0 9665.3 6941.3 6968.0 6977.6 6978.4 7081.4 7213.6 7221.0 7251.9 7292.9 7302.2 06:51:19 INFO - PID 6079 | 06:51:19 INFO - PID 6079 | [#4] prototype.html Cycles:180 Average:5526.60 Median:6165.47 stddev:1554.93 (25.2%) stddev-sans-first:1512.83 06:51:19 INFO - PID 6079 | Values: 499.9 501.3 521.7 522.7 530.3 6193.4 6300.3 6300.7 6398.9 6420.9 5962.2 6063.5 6113.3 6154.9 6182.7 4959.2 4979.2 4994.5 5040.7 5063.3 5006.7 5015.6 5022.8 5058.5 5111.0 4812.7 4869.0 4987.3 5005.5 5006.0 4988.2 5011.5 5022.8 5027.4 5057.4 4484.2 4498.9 4500.3 4508.6 4550.9 6176.1 6182.7 6204.6 6224.2 6230.1 5550.6 5655.7 5701.7 5751.6 5765.6 6468.2 6488.6 6492.5 6538.4 6566.7 4838.9 4868.6 4901.2 4902.8 4909.4 6799.7 6902.0 6939.2 6985.1 7002.3 4958.8 5001.1 5004.7 5025.3 5048.2 5097.6 5100.9 5116.9 5131.6 5136.0 5637.5 5653.9 5701.6 5718.5 5743.0 6527.0 6551.7 6569.3 6584.4 6600.7 1661.2 1679.6 1722.9 1732.1 1757.8 1185.8 1225.1 1227.9 1231.6 1247.2 5623.2 5716.0 5748.8 5762.9 5778.5 6565.6 6593.5 6640.8 6682.8 6699.3 5751.2 5780.6 5784.5 5820.6 5834.7 3536.1 3573.4 3582.0 3585.1 3616.5 6549.8 6594.4 6599.5 6643.7 6680.6 6950.7 6973.8 6977.6 7006.5 7007.7 6530.2 6554.0 6611.7 6634.8 6636.2 6720.2 6728.0 6749.5 6787.0 6805.1 6711.7 6720.7 6750.3 6767.3 6803.6 6516.8 6585.4 6609.7 6618.6 6666.5 4932.4 5000.6 5006.3 5010.1 5036.2 6746.9 6783.4 6798.0 6798.3 6850.8 6499.8 6511.2 6528.5 6539.6 6542.2 6282.6 6414.8 6532.9 6542.9 6578.7 6071.8 6347.9 6432.4 6455.7 6477.8 6382.2 6554.6 6573.9 6585.3 6604.8 6057.6 6240.5 6305.0 6356.3 6363.6 06:51:19 INFO - PID 6079 | 06:51:19 INFO - PID 6079 | [#5] yui.html Cycles:180 Average:24047.94 Median:19045.81 stddev:33475.86 (175.8%) stddev-sans-first:33524.61 06:51:19 INFO - PID 6079 | Values: 889.9 901.2 918.4 918.6 920.1 18889.6 18955.7 19731.9 19781.2 19806.5 18743.3 18794.1 18962.9 19050.0 19126.5 948.9 949.3 960.6 964.2 986.5 1014.8 1015.6 1017.6 1017.9 1020.3 1038.0 1038.1 1038.4 1038.5 1038.6 1047.0 1047.1 1047.7 1047.7 1049.9 766.4 766.6 766.7 766.8 766.8 18961.8 19041.6 19241.1 19398.2 20534.4 21054.2 21486.8 21559.6 21567.5 21637.5 17089.3 17138.9 17192.6 17200.7 17245.3 3751.5 3784.8 3786.7 3788.2 3788.3 125995.0 129500.0 129665.4 131230.3 134138.0 16867.5 17315.9 17316.8 17575.6 17618.8 31213.5 31456.2 31578.0 31726.2 31730.0 8677.7 8693.6 8842.5 8862.6 8864.5 4184.2 4232.0 4296.4 4302.1 4310.0 5035.5 5134.4 5139.4 5144.7 5169.9 1004.3 1067.7 1076.7 1078.6 1079.3 674.1 688.1 691.0 695.4 702.3 10537.8 10833.5 11339.3 11946.6 12465.5 696.1 696.6 701.9 715.1 715.4 5263.5 5425.0 5448.3 5545.1 5547.3 112725.0 115987.0 116678.0 118965.0 120174.0 97145.5 100355.5 101181.5 103843.0 104051.5 86614.0 87358.1 89174.6 89632.0 89894.6 11402.0 11918.5 12031.2 12102.3 12413.7 38948.0 39026.4 39509.6 40876.4 41077.4 59881.7 72447.0 73895.6 75171.2 75383.0 13628.0 13667.8 13722.9 13814.2 13820.3 19851.9 20112.7 20232.0 20727.0 20869.2 16756.5 16818.0 17231.9 17278.5 17399.0 17947.0 17993.3 18179.4 18357.9 18541.4 16524.7 16990.7 17950.0 18647.5 18726.0 11626.6 11786.8 12178.3 12418.8 12639.2 13677.1 13769.7 13822.2 14146.7 14662.5 06:51:19 INFO - PID 6079 | -------- Summary: end -------- 06:51:19 INFO - PID 6079 | 06:51:20 INFO - TEST-INFO | 6079: exit 0 06:51:20 INFO - TEST-OK | dromaeo_css | took 1110406ms 06:51:20 INFO - TEST-START | kraken 06:51:20 INFO - Initialising browser for kraken test... 06:51:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40404/getInfo.html -profile /tmp/tmpRKBtD1/profile 06:51:20 INFO - TEST-INFO | started process 6462 (/builds/slave/test/build/application/firefox/firefox http://localhost:40404/getInfo.html) 06:51:25 INFO - TEST-INFO | 6462: exit 0 06:51:25 INFO - Browser initialized. 06:51:25 INFO - Running cycle 1/1 for kraken test... 06:51:25 INFO - Using env: {'DISPLAY': ':0', 06:51:25 INFO - 'HOME': '/home/cltbld', 06:51:25 INFO - 'JSGC_DISABLE_POISONING': '1', 06:51:25 INFO - 'LANG': 'en_US.UTF-8', 06:51:25 INFO - 'LANGUAGE': 'en_US:en', 06:51:25 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:51:25 INFO - 'LOGNAME': 'cltbld', 06:51:25 INFO - 'MAIL': '/var/mail/cltbld', 06:51:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:51:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:51:25 INFO - 'MOZ_CRASHREPORTER': '1', 06:51:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:51:25 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:51:25 INFO - 'MOZ_NO_REMOTE': '1', 06:51:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:51:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:51:25 INFO - 'NO_EM_RESTART': '1', 06:51:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:51:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:51:25 INFO - 'PWD': '/builds/slave/test', 06:51:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:51:25 INFO - 'RUST_BACKTRACE': 'full', 06:51:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:51:25 INFO - 'SHELL': '/bin/bash', 06:51:25 INFO - 'SHLVL': '1', 06:51:25 INFO - 'STYLO_FORCE_ENABLED': '1', 06:51:25 INFO - 'TERM': 'linux', 06:51:25 INFO - 'TMOUT': '86400', 06:51:25 INFO - 'USER': 'cltbld', 06:51:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313', 06:51:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:51:25 INFO - '_': '/tools/buildbot/bin/python'} 06:51:25 INFO - TEST-INFO | started process 6657 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRKBtD1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:51:26 INFO - PID 6657 | 06:51:26 INFO - PID 6657 | (/builds/slave/test/build/application/firefox/firefox:6709): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:51:26 INFO - PID 6657 | 06:51:36 INFO - PID 6657 | RSS: Main: 173006848 06:51:36 INFO - PID 6657 | 06:51:39 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40404/tests/kraken/driver.html?testName=audio-beat-detection) 06:51:40 INFO - PID 6657 | RSS: Main: 177922048 06:51:40 INFO - PID 6657 | 06:51:42 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40404/tests/kraken/driver.html?testName=audio-dft) 06:51:43 INFO - PID 6657 | RSS: Main: 178171904 06:51:43 INFO - PID 6657 | 06:51:46 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40404/tests/kraken/driver.html?testName=audio-fft) 06:51:47 INFO - PID 6657 | RSS: Main: 172118016 06:51:47 INFO - PID 6657 | 06:51:49 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40404/tests/kraken/driver.html?testName=audio-oscillator) 06:51:49 INFO - PID 6657 | RSS: Main: 172867584 06:51:49 INFO - PID 6657 | 06:51:52 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:51:52 INFO - PID 6657 | RSS: Main: 173305856 06:51:52 INFO - PID 6657 | 06:51:55 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40404/tests/kraken/driver.html?testName=imaging-darkroom) 06:51:56 INFO - PID 6657 | RSS: Main: 176029696 06:51:56 INFO - PID 6657 | 06:51:59 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40404/tests/kraken/driver.html?testName=imaging-desaturate) 06:52:00 INFO - PID 6657 | RSS: Main: 176001024 06:52:00 INFO - PID 6657 | 06:52:03 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40404/tests/kraken/driver.html?testName=json-parse-financial) 06:52:04 INFO - PID 6657 | RSS: Main: 176148480 06:52:04 INFO - PID 6657 | 06:52:05 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:52:06 INFO - PID 6657 | RSS: Main: 176025600 06:52:06 INFO - PID 6657 | 06:52:07 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:52:08 INFO - PID 6657 | RSS: Main: 176087040 06:52:08 INFO - PID 6657 | 06:52:10 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:52:11 INFO - PID 6657 | RSS: Main: 173109248 06:52:11 INFO - PID 6657 | 06:52:13 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:52:14 INFO - PID 6657 | RSS: Main: 173535232 06:52:14 INFO - PID 6657 | 06:52:17 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:52:18 INFO - PID 6657 | RSS: Main: 173330432 06:52:18 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | Cycle 1(1): loaded http://localhost:40404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40404/tests/kraken/driver.html?testName=ai-astar) 06:52:20 INFO - PID 6657 | RSS: Main: 174981120 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | __start_tp_report 06:52:20 INFO - PID 6657 | _x_x_mozilla_page_load 06:52:20 INFO - PID 6657 | _x_x_mozilla_page_load_details 06:52:20 INFO - PID 6657 | |i|pagename|runs| 06:52:20 INFO - PID 6657 | |0;ai-astar;97;109;100;108;106;109;110;102;107;109 06:52:20 INFO - PID 6657 | |1;audio-beat-detection;141;115;138;177;118;149;147;116;172;133 06:52:20 INFO - PID 6657 | |2;audio-dft;163;165;163;162;162;163;161;164;167;168 06:52:20 INFO - PID 6657 | |3;audio-fft;74;74;74;182;75;75;76;73;147;76 06:52:20 INFO - PID 6657 | |4;audio-oscillator;79;78;128;78;78;77;136;79;79;128 06:52:20 INFO - PID 6657 | |5;imaging-gaussian-blur;114;114;114;114;113;114;115;114;114;115 06:52:20 INFO - PID 6657 | |6;imaging-darkroom;161;149;148;149;148;149;148;147;150;149 06:52:20 INFO - PID 6657 | |7;imaging-desaturate;94;93;94;94;94;95;94;94;94;94 06:52:20 INFO - PID 6657 | |8;json-parse-financial;55;52;51;53;51;53;57;52;55;52 06:52:20 INFO - PID 6657 | |9;json-stringify-tinderbox;37;37;38;38;38;38;38;38;37;37 06:52:20 INFO - PID 6657 | |10;stanford-crypto-aes;75;74;75;78;75;76;75;74;77;74 06:52:20 INFO - PID 6657 | |11;stanford-crypto-ccm;126;126;127;116;116;118;129;125;121;161 06:52:20 INFO - PID 6657 | |12;stanford-crypto-pbkdf2;166;171;166;170;165;171;181;169;171;167 06:52:20 INFO - PID 6657 | |13;stanford-crypto-sha256-iterative;65;65;66;65;65;67;64;66;64;67 06:52:20 INFO - PID 6657 | __end_tp_report 06:52:20 INFO - PID 6657 | __start_cc_report 06:52:20 INFO - PID 6657 | _x_x_mozilla_cycle_collect,924 06:52:20 INFO - PID 6657 | __end_cc_report 06:52:20 INFO - PID 6657 | __startTimestamp1504187540269__endTimestamp 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | ------- Summary: start ------- 06:52:20 INFO - PID 6657 | Number of tests: 14 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#0] ai-astar Cycles:10 Average:105.70 Median:109.00 stddev:4.47 (4.1%) stddev-sans-first:3.46 06:52:20 INFO - PID 6657 | Values: 97.0 109.0 100.0 108.0 106.0 109.0 110.0 102.0 107.0 109.0 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:144.00 stddev:21.75 (15.1%) stddev-sans-first:23.07 06:52:20 INFO - PID 6657 | Values: 141.0 115.0 138.0 177.0 118.0 149.0 147.0 116.0 172.0 133.0 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.25 (1.4%) stddev-sans-first:2.37 06:52:20 INFO - PID 6657 | Values: 163.0 165.0 163.0 162.0 162.0 163.0 161.0 164.0 167.0 168.0 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#3] audio-fft Cycles:10 Average:92.60 Median:74.50 stddev:38.79 (52.1%) stddev-sans-first:40.56 06:52:20 INFO - PID 6657 | Values: 74.0 74.0 74.0 182.0 75.0 75.0 76.0 73.0 147.0 76.0 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:78.00 stddev:25.40 (32.6%) stddev-sans-first:26.36 06:52:20 INFO - PID 6657 | Values: 79.0 78.0 128.0 78.0 78.0 77.0 136.0 79.0 79.0 128.0 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:52:20 INFO - PID 6657 | Values: 114.0 114.0 114.0 114.0 113.0 114.0 115.0 114.0 114.0 115.0 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:149.00 stddev:4.02 (2.7%) stddev-sans-first:0.88 06:52:20 INFO - PID 6657 | Values: 161.0 149.0 148.0 149.0 148.0 149.0 148.0 147.0 150.0 149.0 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 06:52:20 INFO - PID 6657 | Values: 94.0 93.0 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:1.97 (3.7%) stddev-sans-first:1.96 06:52:20 INFO - PID 6657 | Values: 55.0 52.0 51.0 53.0 51.0 53.0 57.0 52.0 55.0 52.0 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#9] json-stringify-tinderbox Cycles:10 Average:37.60 Median:38.00 stddev:0.52 (1.4%) stddev-sans-first:0.50 06:52:20 INFO - PID 6657 | Values: 37.0 37.0 38.0 38.0 38.0 38.0 38.0 38.0 37.0 37.0 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.00 stddev:1.34 (1.8%) stddev-sans-first:1.41 06:52:20 INFO - PID 6657 | Values: 75.0 74.0 75.0 78.0 75.0 76.0 75.0 74.0 77.0 74.0 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:126.00 stddev:13.01 (10.3%) stddev-sans-first:13.79 06:52:20 INFO - PID 6657 | Values: 126.0 126.0 127.0 116.0 116.0 118.0 129.0 125.0 121.0 161.0 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:170.50 stddev:4.60 (2.7%) stddev-sans-first:4.68 06:52:20 INFO - PID 6657 | Values: 166.0 171.0 166.0 170.0 165.0 171.0 181.0 169.0 171.0 167.0 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:1.07 (1.6%) stddev-sans-first:1.13 06:52:20 INFO - PID 6657 | Values: 65.0 65.0 66.0 65.0 65.0 67.0 64.0 66.0 64.0 67.0 06:52:20 INFO - PID 6657 | -------- Summary: end -------- 06:52:20 INFO - PID 6657 | 06:52:20 INFO - PID 6657 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:52:20 INFO - TEST-INFO | 6657: exit 0 06:52:20 INFO - TEST-OK | kraken | took 60552ms 06:52:20 INFO - SUITE-END | took 1170s 06:52:21 INFO - Completed test suite (00:19:31) 06:52:21 INFO - javascript benchmark 06:52:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8580.827884041082, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3300.7029367356936, 3306.9007929762115, 3316.005198440468, 3338.7829791063577, 3346.4645656694934, 6272.0, 6283.434490895818, 6293.779717709881, 6322.304546499881, 6364.172657554512, 6054.727537260823, 6177.505799536038, 6187.35032821554, 6194.938050619492, 6199.721012554434, 5746.1668058131445, 5769.3076830780365, 5777.248957635502, 5784.56615753818, 5819.185314056035, 5692.829215123553, 5817.301923769153, 5818.650880947135, 5824.679642619654, 5850.795222167225, 5856.355800861902, 5862.443067908542, 5894.204282421861, 5922.2597175353085, 5936.109583562457, 5828.096645020008, 5868.0, 5879.441453061952, 5924.052151655715, 5936.079907614327, 5172.120739474299, 5589.944100559023, 5702.429757024306, 5733.770649174028, 5819.7672093116225, 6268.937310626927, 6303.3066362700065, 6321.525885558555, 6333.398327158959, 6411.230652321751, 6636.8008959730805, 6682.365175308387, 6725.461963042945, 6790.932090679079, 6869.553479023847, 6714.899276510856, 6733.663316834188, 6786.524943253974, 6817.250102488722, 6826.180858296986, 6218.378162183745, 6227.09707092469, 6320.905186422253, 6324.873502529969, 6338.271098823649, 6819.7272109116075, 6864.656767161622, 6872.862542749117, 6909.619970901548, 6913.274106218875, 6614.603123812587, 6642.036904648799, 6657.800265991931, 6663.600183988976, 6700.49746269022, 6680.131582894192, 6714.764983225564, 6768.153980752406, 6806.727730890709, 6814.250432452426, 6615.569987950767, 6661.666916654148, 6708.731650733916, 6710.127683401224, 6785.796426107225, 6739.831504212434, 6771.153605799275, 6804.6257455840405, 6827.214870289881, 6838.384545390939, 5277.973610131925, 5289.259503669489, 5360.3299587551555, 5362.544183744425, 5373.032854086224, 4534.229181039232, 4564.680472366902, 4601.746903920316, 4615.892185875433, 4646.233371493733, 5920.822375328747, 5937.228160339128, 5952.791652292149, 5954.702264886739, 5959.195508606369, 6750.0, 6799.422049125781, 6825.0, 6867.931320686729, 6891.931080689229, 5795.565332600072, 5822.883542329129, 5888.558358123158, 5924.763009479572, 5945.316288626776, 5703.828885133453, 5776.220210271644, 5788.479036886701, 5868.471837534642, 5901.40985901415, 6517.283098859121, 6555.475561955032, 6589.110470086573, 6627.37039981201, 6637.933620663828, 6742.797716068526, 6750.8649827004165, 6833.384995350442, 6850.931490685129, 6858.211305699909, 6436.517261205522, 6504.544681872224, 6529.118568993125, 6564.179477565304, 6585.078089067631, 6598.307177746459, 6614.933850661432, 6623.701933412912, 6662.733490660319, 6712.664366781739, 6844.794656160323, 6901.137357830271, 6919.827004324932, 6925.6190909500465, 6928.099347084847, 6506.9263571512065, 6514.218293804774, 6536.444402225674, 6624.0, 6624.006399040182, 6467.870642587028, 6526.477881769352, 6551.44312733404, 6561.671916404256, 6614.735410583715, 6461.0, 6486.870262594816, 6532.987386955029, 6539.051837483634, 6545.574537655038, 6400.967995160181, 6526.510511711545, 6539.803805885831, 6540.182477190351, 6564.737410503717, 6218.502519798315, 6239.313675495601, 6241.812745617639, 6242.157308763441, 6245.750169993149], "value": 6155.749349458902, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.3257062923086, 857.6183598298757, 887.0287035695915, 895.9910400895991, 1148.9195756297052, 30883.22791930203, 41589.16821663565, 42292.57707422925, 42315.78842105785, 42346.788266058626, 41714.0, 42363.152736945245, 42396.0, 42420.363694544605, 42514.57485425145, 7329.19378868324, 7750.96124519378, 7992.760217193464, 7996.600169991506, 8005.239502247277, 7790.727324543642, 7922.524648521078, 7928.445008849383, 7929.484583502082, 7929.563873986928, 7883.8423231535335, 7949.046114466243, 7963.163867793885, 7971.123176450586, 7989.960050199741, 7898.644560994769, 7929.603519823986, 7929.841403171933, 7929.96035019827, 7931.127575966639, 7861.764147075597, 7933.325667318285, 7933.563653999027, 7938.44430889838, 7939.404544659116, 38364.61635383666, 38695.8065209675, 38736.22527549433, 38737.41893871594, 38801.80599097015, 3529.2235708144167, 3556.039869235318, 3558.6085530591613, 3574.6425357464304, 3582.15819282471, 31450.685493145003, 31464.213394665087, 31471.685283147333, 31519.527207091913, 31604.841975790205, 5050.368703912011, 5157.174852023658, 5168.896622067575, 5200.609954253446, 5221.556167725748, 189935.0, 191042.0, 191099.0, 191330.0, 191481.9999999986, 48758.51241487611, 48823.755881220364, 48830.51169488331, 48844.0, 48967.265491017664, 50471.24293135606, 50561.49438505568, 50588.49411505911, 50645.0, 50672.74663626732, 12763.17039392455, 15118.244087795567, 15276.694466110615, 15348.616284592974, 15367.538973830802, 10473.057424831803, 11328.0, 11515.884841151648, 11536.365499897585, 11590.594329198437, 14272.286385680674, 14348.49780257686, 14390.208538530482, 14451.566453006426, 14574.344154513072, 5784.681842498619, 5785.09506083392, 5853.912191317134, 5880.705964701748, 5903.704814759245, 996.6412091647002, 1012.4633944009687, 1019.2304809868501, 1034.715453250362, 1036.828923227659, 22678.319650410514, 22682.206122785625, 22968.885155574448, 22999.655005174936, 23168.65247021296, 1133.070881876853, 1133.5975728616222, 1133.790248803974, 1138.1748232531513, 1139.2594813371375, 12025.879741202476, 12205.633830985085, 12219.522296012736, 12297.631071067703, 12317.260964342167, 223352.0, 225247.0, 226753.0, 226981.0, 227349.0, 52280.47719522756, 52548.0, 52701.7364913173, 52720.0, 52924.735376322875, 1424.7934049562962, 1440.8415074341815, 1441.4882716635652, 1452.7239824433325, 1456.774199999023, 22470.0, 22655.773442266025, 22720.0, 22751.0, 22977.0, 36858.8157059213, 36906.8154659225, 36934.8153259232, 36952.81523592365, 36984.26031479409, 188285.0, 188472.0, 189440.0, 189454.0, 189963.0, 33437.33125337431, 35033.474497883064, 35254.64745352514, 35279.11802204965, 35387.0, 44528.33207501955, 45709.0, 45782.54217457916, 45816.0, 45989.540104599866, 33648.49527257044, 33652.3269534603, 33673.66326336705, 33755.83122084374, 33801.49297760487, 33111.17222069467, 33367.33265334728, 33403.16492087717, 33656.49515257322, 34428.0, 33329.33341333208, 33347.33305333831, 33613.66386336106, 33636.66363336335, 33663.0, 32858.835705821315, 32934.34131317408, 33071.50392744159, 33188.17029574183, 33369.83315083409, 24323.513529729662, 24707.752922470547, 24830.130945416822, 25358.74641253564, 25369.74630253748], "value": 17217.243399158462, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6842984770865, 571.2858926342072, 578.2020811280433, 583.1427801132334, 599.5713065158411, 22089.226877059307, 22654.88672556639, 22887.19894803682, 22907.541849163008, 22908.427289317777, 25256.116035938747, 26069.348266293353, 26070.305430147026, 26113.216603501878, 26113.869430652867, 6614.272430032693, 6787.117674702282, 6788.5587436816695, 6789.117414736102, 6795.0, 6096.908546371808, 6662.100616416795, 6662.333766623347, 6702.631355275458, 6724.193096828363, 6631.171103612049, 6632.568883022588, 6633.038209459625, 6634.568753031038, 6636.369544893251, 6660.733570657168, 6661.367170118831, 6661.533692641517, 6662.0, 6662.56693314933, 6139.416755408229, 6145.78489752861, 6158.445739883387, 6159.969200153971, 6174.7530098796, 27963.440731185263, 28753.85623071892, 28891.56662650062, 28947.276318092216, 29490.262743431587, 2038.0523056778668, 2096.3815674376096, 2098.087332010565, 2099.3911765588114, 2101.2225476573767, 19052.71420928687, 19619.607607847905, 19638.01809909513, 19649.115789789495, 19740.210391584318, 2375.6674065630827, 2426.1993542131054, 2450.0812195426715, 2469.3085935937966, 2507.0723832182025, 130211.0, 133216.33391833075, 133237.3338133303, 133949.3302533491, 133989.0, 14097.295135243197, 14348.49780257686, 14707.117572945657, 14781.92609036948, 14839.183844888636, 23152.305430837103, 23275.76724232736, 23278.0, 23283.18508852182, 23306.067757289857, 9711.708648740549, 9805.754856128511, 9826.115649591571, 9942.30403871722, 10031.39811611291, 9068.637254509746, 9079.863802042975, 9193.63225470987, 9213.078692130868, 9250.72247832566, 7575.09882410559, 8929.553522323858, 9045.77385565366, 9223.800905882192, 9233.861492077624, 2565.0, 2592.131635901994, 2601.323655849455, 2658.86705664716, 2718.7281271872653, 979.7060881735451, 984.242133557157, 997.8154041502345, 1005.9497025148713, 1012.1093437774712, 19725.802741972682, 19863.801361986196, 19965.731355809272, 19967.900160499106, 20267.493312667302, 1043.4209013997304, 1050.9474526273655, 1056.1656291529605, 1056.3714589819044, 1058.6453538064682, 10882.455877206108, 10926.399048052433, 10948.34309941406, 10972.615958441416, 11259.605913792979, 449024.0, 454976.0, 511124.0, 522691.0, 523939.0, 113149.0, 116913.0, 118919.40540297244, 119613.0, 120059.0, 1230.8830661087181, 1231.759806837658, 1268.9428975696117, 1277.163457935054, 1280.5326055989683, 20140.0, 20831.0, 20856.165753369696, 20965.0, 21435.46411339729, 53537.46462535325, 54276.72861635667, 55055.72472137614, 55223.44776552183, 56233.0, 69333.30666693268, 69390.65304673444, 70004.0, 70679.64660176667, 77241.2275877234, 16151.919240403722, 20899.268525601532, 21046.158153674292, 21581.46046348791, 22234.221802236843, 23782.88108559446, 23794.286171414886, 24081.638775418032, 24381.26856194317, 24449.38876528101, 17920.551986199927, 18928.52678683044, 19090.904545477184, 19632.705509417658, 19650.21399144018, 16238.918805405898, 16704.33182672728, 16767.74848377251, 17261.482155535356, 17337.82662173362, 19617.215311387383, 19915.402537923885, 20013.899930500254, 20162.29431969874, 20191.394258172277, 20905.581888362452, 21029.0, 21070.894645526674, 21207.363779086652, 21226.0, 16900.0, 17066.2320195589, 17078.316867325666, 18342.0, 18667.346642867433], "value": 12311.98248662392, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.429042656871, 1402.782568701851, 1411.9904268448058, 1412.0821466047075, 1416.9797745623148, 14802.555923322305, 15578.844211557895, 15582.220888955564, 15586.688266234683, 16035.599110022255, 15706.528804135865, 15994.680106397866, 16012.959157654745, 16023.599410014725, 16025.919870400632, 2659.149072296861, 2661.8802153903025, 2722.2922040269573, 2723.2511059458707, 2836.1633318171084, 2747.285705716518, 2781.652293463317, 2795.888164473419, 2810.00244913056, 2810.873510692024, 2707.2690373599116, 2733.7539621434066, 2733.8906443742226, 2747.285705716508, 2764.04640399063, 2608.660874086366, 2641.7886569074526, 2655.7078721340636, 2662.480816240834, 2672.759451649361, 2621.855797931113, 2629.4346715456077, 2634.894604215829, 2642.3394151462135, 2642.445086531831, 14796.334164962602, 15108.244587770567, 15108.924455377763, 15141.091534507965, 15162.469313573973, 8081.919180808175, 8421.410501264914, 8435.198656127657, 8438.0, 8442.535660538668, 5388.218708287315, 5547.362053363874, 5582.692951887645, 5685.857853553653, 5712.457316554921, 1855.5361159710073, 1871.7660292463443, 1886.5566591850904, 1914.5692219250695, 1922.846172306212, 26795.73204267952, 26961.0563630272, 27042.72957270422, 27051.0, 27079.458410831674, 6750.797476075725, 6778.254392016875, 6804.149481314836, 6925.342092501204, 7016.36852683261, 17573.20920558578, 17581.38465153739, 17582.560435988948, 17603.0, 17628.823711762718, 7836.451448398558, 8087.069986951458, 8091.838163236703, 8093.473924194908, 8097.0, 7418.332350088518, 7472.738454154187, 7509.3617042552, 7578.280063394079, 7624.085109786861, 5200.739963001834, 5346.144616861284, 5375.784968601212, 5410.810621628303, 5412.323459567554, 1478.2830327291256, 1486.717523670499, 1496.85779850914, 1499.3702644889172, 1500.197394393994, 848.974530764078, 864.1876635962176, 888.1296329596902, 891.2023738753779, 904.2268860124631, 7729.304362607392, 7752.4573279869865, 7792.883106753403, 7798.883016754753, 7830.021247344082, 720.585663243637, 738.1621859189859, 739.7669734033763, 747.0922828763079, 763.7975936376864, 5139.511746384088, 5646.160610784706, 5705.372409035002, 5707.400722924116, 5861.296644402613, 21190.47023824417, 22141.225057122923, 22418.215362462237, 22453.32640020802, 22503.0, 21085.262015829372, 22071.11715531361, 22099.33701988943, 22105.336839894506, 22177.445563861034, 11285.605003824827, 11321.886781132249, 11525.76948461026, 11555.537778488935, 11561.88438115608, 8606.65573377058, 8630.0, 8637.784055398413, 8752.693655722274, 8781.824363512565, 18113.45659630213, 18540.351087712406, 18748.250069997048, 18807.0, 19040.61918761645, 18946.621067578297, 19119.13963871657, 19153.233870645574, 19180.904095479433, 19359.903200483906, 10662.680119596425, 10821.242513024014, 10823.67528974132, 10835.837462438227, 10838.945805271238, 13283.800742989057, 13411.597652070453, 13535.59393218205, 13546.93226533861, 13553.661158471117, 11065.668029959113, 11102.167337449562, 11133.0, 11268.267562608404, 11405.0, 10118.392896426238, 10147.949260253652, 10212.744681383025, 10274.229432792421, 10383.480825958823, 9432.481213533321, 9564.904350956402, 9629.566669499749, 9652.951735241279, 9665.3234273603, 6941.34057264559, 6967.965160174167, 6977.581345119309, 6978.371946524837, 7081.398081163159, 7213.567185968858, 7221.0, 7251.927480725125, 7292.854142917218, 7302.160251571137], "value": 6649.524983388122, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.87003379121415, 501.3432403551348, 521.6531006880425, 522.699447817505, 530.2814686100334, 6193.411625895538, 6300.306966233722, 6300.684965751711, 6398.936010639893, 6420.903686444707, 5962.195103661015, 6063.484603808682, 6113.32753397126, 6154.876902461948, 6182.732539829324, 4959.231319145538, 4979.203327467606, 4994.525520075587, 5040.747962601855, 5063.265826455171, 5006.749662516878, 5015.5736762375245, 5022.82420115296, 5058.494150584949, 5110.9744451277875, 4812.711237325754, 4868.97565512172, 4987.251912213161, 5005.499450054984, 5006.0, 4988.152014157584, 5011.473795251519, 5022.8196373852115, 5027.371578552681, 5057.418396884369, 4484.1928452878465, 4498.8875278117985, 4500.324951257305, 4508.61676757476, 4550.863474095782, 6176.054542819043, 6182.732539829324, 6204.565680402374, 6224.159738435299, 6230.096635987802, 5550.639208451437, 5655.745491452894, 5701.6864072476, 5751.597388182829, 5765.567582431292, 6468.159139311906, 6488.610683359014, 6492.513061520358, 6538.411542961157, 6566.70449829754, 4838.927416088762, 4868.563773686736, 4901.181820453254, 4902.828401005983, 4909.386326709161, 6799.7280108796085, 6901.965490172567, 6939.167299924042, 6985.126859142607, 7002.258148318381, 4958.8181200271765, 5001.074801161797, 5004.724740139327, 5025.296458495741, 5048.242763585492, 5097.572679649704, 5100.872478188001, 5116.948830511647, 5131.61512886535, 5136.0241554104605, 5637.548996080303, 5653.858653533694, 5701.629394089371, 5718.4567466091485, 5743.013632910863, 6526.967365163144, 6551.706902584057, 6569.343065693392, 6584.407403333723, 6600.73597056122, 1661.1860188507785, 1679.638877641313, 1722.922468488921, 1732.1079643983358, 1757.7627020352345, 1185.8280549320473, 1225.0934308611563, 1227.9079069069676, 1231.5566396097397, 1247.2267194339386, 5623.156526520973, 5715.971420142956, 5748.780682817552, 5762.855928601818, 5778.479936805624, 6565.601047298322, 6593.505487088488, 6640.800775976729, 6682.799516014527, 6699.263081061079, 5751.217122691979, 5780.624259423124, 5784.537237021028, 5820.621659592113, 5834.708264586839, 3536.133647256387, 3573.4282514797505, 3581.982090089533, 3585.1395665040723, 3616.4575313703153, 6549.770758023446, 6594.373534514213, 6599.472042236705, 6643.734250629921, 6680.594985805106, 6950.687219075154, 6973.8493148629905, 6977.581345119309, 7006.474514411338, 7007.684654190573, 6530.1510803596175, 6553.967230163818, 6611.702473388709, 6634.767783127568, 6636.170478690164, 6720.193576770819, 6728.0, 6749.527533072835, 6786.966065169642, 6805.149356330458, 6711.731530738911, 6720.663966801738, 6750.32496750321, 6767.25560188369, 6803.625800581016, 6516.771912983023, 6585.407313341822, 6609.669516524058, 6618.602883826986, 6666.533342665967, 4932.383452068491, 5000.624953128603, 5006.274090256965, 5010.123228434936, 5036.1942089267, 6746.9325306746305, 6783.423409010289, 6797.980302954398, 6798.252192258748, 6850.760223392357, 6499.772507962199, 6511.186101737283, 6528.474623703147, 6539.574927629879, 6542.182227221598, 6282.623042617458, 6414.807555773335, 6532.902006469812, 6542.934570654233, 6578.736850525926, 6071.848203794941, 6347.936520634735, 6432.421082102634, 6455.741770329322, 6477.77327793525, 6382.20222472191, 6554.573952693059, 6573.901391479228, 6585.275619681735, 6604.7781160485465, 6057.636541807506, 6240.500759939103, 6304.968475157778, 6356.332585078685, 6363.5863668861375], "value": 5067.426760447226, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.9466032038079, 901.1709227510686, 918.3800934369308, 918.5958178401505, 920.102899672819, 18889.622207555876, 18955.715664265048, 19731.901340493296, 19781.208751649934, 19806.504837379038, 18743.250269989185, 18794.06029698513, 18962.905185474054, 19050.0, 19126.52183695408, 948.9383190092622, 949.3022628368144, 960.6157536985227, 964.1900803325206, 986.4574484033752, 1014.7666036811538, 1015.6496008876926, 1017.6133069433605, 1017.8574999500075, 1020.3061917895828, 1037.9792404151913, 1038.1176000399637, 1038.4288641247322, 1038.532660302863, 1038.6209033702683, 1046.9528871200814, 1047.0681093826463, 1047.6647472808704, 1047.675220681591, 1049.8582691336649, 766.3677466090497, 766.5898744171841, 766.6626684258908, 766.7814672818275, 766.8427972265728, 18961.810381896143, 19041.619167616707, 19241.13414896333, 19398.22407103714, 20534.383968480968, 21054.157833686633, 21486.785132148634, 21559.568808623895, 21567.460813479633, 21637.45906352338, 17089.316427342892, 17138.914305428516, 17192.57018574533, 17200.741988870177, 17245.310187592608, 3751.5123034005405, 3784.7729136251914, 3786.734928555002, 3788.1666033472593, 3788.2802267569073, 125995.0, 129499.99999999905, 129665.35167324104, 131230.3438482811, 134138.0, 16867.493975180765, 17315.91342043282, 17316.82683173152, 17575.560610984572, 17618.823811761973, 31213.531797023064, 31456.213594660316, 31578.0, 31726.2068448286, 31730.0, 8677.652893884175, 8693.565321733888, 8842.513661748537, 8862.556872156367, 8864.512451815212, 4184.205001049791, 4232.047789247456, 4296.398504209413, 4302.118065796567, 4309.956900431018, 5035.521625445577, 5134.409542902539, 5139.383274007068, 5144.6655967362, 5169.870753231199, 1004.322082594246, 1067.6957067235955, 1076.7146706122883, 1078.6224821312478, 1079.2553138334524, 674.1000763980142, 688.1295161620554, 691.0463560286772, 695.3624214973765, 702.3292755418563, 10537.84193237102, 10833.512491937881, 11339.319640821577, 11946.641600751991, 12465.5013799447, 696.0799446322628, 696.613379574331, 701.8596280743769, 715.0704084689883, 715.3847690985748, 5263.499967503081, 5424.972875135599, 5448.264484294648, 5545.112781954948, 5547.33431988164, 112725.0, 115987.0, 116678.0, 118965.0, 120174.0, 97145.5142724296, 100355.49822250842, 101181.49409252907, 103843.0, 104051.47974260231, 86614.0, 87358.126418735, 89174.55412722896, 89632.0, 89894.55052724826, 11402.0, 11918.523259069887, 12031.2101687968, 12102.273863568214, 12413.689657758629, 38948.0, 39026.41460378154, 39509.604903950596, 40876.38685419781, 41077.38383924303, 59881.700591498506, 72447.0, 73895.63052184919, 75171.24828751643, 75383.0, 13628.0, 13667.79498307546, 13722.862771372558, 13814.240216788174, 13820.308984550933, 19851.900740496207, 20112.698309525076, 20232.0, 20727.0, 20869.1652333911, 16756.497305080866, 16818.0, 17231.913840431218, 17278.481645550655, 17399.043052632227, 17947.01291428984, 17993.280268789626, 18179.363722269656, 18357.908210459398, 18541.44375668732, 16524.66950661004, 16990.745138823175, 17950.0, 18647.533811654816, 18726.0, 11626.593069242535, 11786.823197651871, 12178.269303841798, 12418.813717794059, 12639.241645501299, 13677.110987785762, 13769.682000617522, 13822.203113595167, 14146.717065658424, 14662.486812961923], "value": 9078.169385565054, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1482.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 109.0, 100.0, 108.0, 106.0, 109.0, 110.0, 102.0, 107.0, 109.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 115.0, 138.0, 177.0, 118.0, 149.0, 147.0, 116.0, 172.0, 133.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 162.0, 162.0, 163.0, 161.0, 164.0, 167.0, 168.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 182.0, 75.0, 75.0, 76.0, 73.0, 147.0, 76.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 128.0, 78.0, 78.0, 77.0, 136.0, 79.0, 79.0, 128.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0, 114.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 149.0, 148.0, 149.0, 148.0, 149.0, 148.0, 147.0, 150.0, 149.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 51.0, 53.0, 51.0, 53.0, 57.0, 52.0, 55.0, 52.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 37.0, 37.0], "value": 37.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 78.0, 75.0, 76.0, 75.0, 74.0, 77.0, 74.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 127.0, 116.0, 116.0, 118.0, 129.0, 125.0, 121.0, 161.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 171.0, 166.0, 170.0, 165.0, 171.0, 181.0, 169.0, 171.0, 167.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 65.0, 67.0, 64.0, 66.0, 64.0, 67.0], "value": 65.4, "unit": "score"}]}]} 06:52:21 INFO - Return code: 0 06:52:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:52:21 INFO - # TBPL SUCCESS # 06:52:21 INFO - Running post-action listener: _package_coverage_data 06:52:21 INFO - Running post-action listener: _resource_record_post_action 06:52:21 INFO - [mozharness: 2017-08-31 13:52:21.544126Z] Finished run-tests step (success) 06:52:21 INFO - Running post-run listener: _resource_record_post_run 06:52:21 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 393891840; Read time: 28; Write time: 223112 06:52:21 INFO - TinderboxPrint: CPU usage
13.1% 06:52:21 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 06:52:21 INFO - TinderboxPrint: I/O write bytes / time
393,891,840 / 223,112 06:52:21 INFO - TinderboxPrint: CPU idle
8,232.9 (86.9%) 06:52:21 INFO - TinderboxPrint: CPU user
1,192.5 (12.6%) 06:52:21 INFO - TinderboxPrint: Swap in / out
0 / 0 06:52:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106876928; Read time: 0; Write time: 67328 06:52:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:52:21 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8192; Write bytes: 286826496; Read time: 28; Write time: 155784 06:52:22 INFO - Running post-run listener: _upload_blobber_files 06:52:22 INFO - Blob upload gear active. 06:52:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:52:22 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 06:52:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:52:22 INFO - (blobuploader) - INFO - Open directory for files ... 06:52:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:52:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:52:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:52:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:52:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:52:23 INFO - (blobuploader) - INFO - Done attempting. 06:52:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:52:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:52:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:52:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:52:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:52:27 INFO - (blobuploader) - INFO - Done attempting. 06:52:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:52:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:52:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:52:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:52:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:52:28 INFO - (blobuploader) - INFO - Done attempting. 06:52:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:52:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:52:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:52:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:52:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:52:29 INFO - (blobuploader) - INFO - Done attempting. 06:52:29 INFO - (blobuploader) - INFO - Iteration through files over. 06:52:29 INFO - Return code: 0 06:52:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:52:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:52:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/855d002619c3e2e4048cfa8ccf378c263c352de367bda8aa46394461c10d3c982a71e8c4339e4daec06dc194fff99947f2987079d67908aadb634a0952a22903", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8d6a3c9794bd0e8c8b295e262a9ac40a5332e668f10623938139fd3296568d8fcf2861237c87f4de56f35fda84023c41341b7359fab691eea70bb41270c1ea8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/342da88d13729b5e21ecb953924318eb6a8eb40d79e9e5f69f0a693a9a70517b216940376bfc8c9826048163d2f54a9b464b6f371e8770316fe9a8882e47b030", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f1ffb404a79f9aa5d3076f97901dec961c5e21145348218810e61200ce3789229cda6a08d2f8b519dab533bfa6cd9e0a45c4e1620a11a96020d4d750f495701"} 06:52:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:52:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:52:29 INFO - Contents: 06:52:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/855d002619c3e2e4048cfa8ccf378c263c352de367bda8aa46394461c10d3c982a71e8c4339e4daec06dc194fff99947f2987079d67908aadb634a0952a22903", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8d6a3c9794bd0e8c8b295e262a9ac40a5332e668f10623938139fd3296568d8fcf2861237c87f4de56f35fda84023c41341b7359fab691eea70bb41270c1ea8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/342da88d13729b5e21ecb953924318eb6a8eb40d79e9e5f69f0a693a9a70517b216940376bfc8c9826048163d2f54a9b464b6f371e8770316fe9a8882e47b030", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f1ffb404a79f9aa5d3076f97901dec961c5e21145348218810e61200ce3789229cda6a08d2f8b519dab533bfa6cd9e0a45c4e1620a11a96020d4d750f495701"} 06:52:29 INFO - Running post-run listener: copy_logs_to_upload_dir 06:52:29 INFO - Copying logs to upload dir... 06:52:29 INFO - mkdir: /builds/slave/test/build/upload/logs 06:52:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1308.684867 ========= master_lag: 0.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 49 secs) (at 2017-08-31 06:52:30.079356) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 06:52:30.082574) ========= 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=923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/855d002619c3e2e4048cfa8ccf378c263c352de367bda8aa46394461c10d3c982a71e8c4339e4daec06dc194fff99947f2987079d67908aadb634a0952a22903", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8d6a3c9794bd0e8c8b295e262a9ac40a5332e668f10623938139fd3296568d8fcf2861237c87f4de56f35fda84023c41341b7359fab691eea70bb41270c1ea8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/342da88d13729b5e21ecb953924318eb6a8eb40d79e9e5f69f0a693a9a70517b216940376bfc8c9826048163d2f54a9b464b6f371e8770316fe9a8882e47b030", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f1ffb404a79f9aa5d3076f97901dec961c5e21145348218810e61200ce3789229cda6a08d2f8b519dab533bfa6cd9e0a45c4e1620a11a96020d4d750f495701"} build_url:https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011718 build_url: 'https://queue.taskcluster.net/v1/task/RI4nAJyITZ2MQzniRVqbBQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/855d002619c3e2e4048cfa8ccf378c263c352de367bda8aa46394461c10d3c982a71e8c4339e4daec06dc194fff99947f2987079d67908aadb634a0952a22903", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8d6a3c9794bd0e8c8b295e262a9ac40a5332e668f10623938139fd3296568d8fcf2861237c87f4de56f35fda84023c41341b7359fab691eea70bb41270c1ea8", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/342da88d13729b5e21ecb953924318eb6a8eb40d79e9e5f69f0a693a9a70517b216940376bfc8c9826048163d2f54a9b464b6f371e8770316fe9a8882e47b030", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f1ffb404a79f9aa5d3076f97901dec961c5e21145348218810e61200ce3789229cda6a08d2f8b519dab533bfa6cd9e0a45c4e1620a11a96020d4d750f495701"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-31 06:52:30.117599) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:52:30.117993) ========= 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=923d835db2ba3686ebe126b700000192-1504186238.674164-1639552313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-31 06:52:30.200474) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 06:52:30.200833) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-31 06:52:30.201170) ========= ========= Total master_lag: 0.66 =========