builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1503318574.1 results: success (0) revision: ecf9cc9bfca0853c22f7cf78a88b5762a002164e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 05:29:34.102533) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 05:29:34.102980) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 05:29:34.103294) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 05:29:34.115920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:29:34.116189) ========= 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=9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-21 05:29:35-- 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% 68.7M=0s 2017-08-21 05:29:35 (68.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.330189 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:29:34.464636) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:29:34.464964) ========= 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=9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020732 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:29:34.518375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-21 05:29:34.518711) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ecf9cc9bfca0853c22f7cf78a88b5762a002164e --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 ecf9cc9bfca0853c22f7cf78a88b5762a002164e --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=9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-21 05:29:35,460 truncating revision to first 12 chars 2017-08-21 05:29:35,460 Setting DEBUG logging. 2017-08-21 05:29:35,460 attempt 1/10 2017-08-21 05:29:35,460 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ecf9cc9bfca0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-21 05:29:36,105 attempt 1/10 2017-08-21 05:29:36,775 current task status: no status available at this point. state: STARTED 2017-08-21 05:29:36,775 sleeping for 9.00s (attempt 1/10) 2017-08-21 05:29:45,785 attempt 2/10 2017-08-21 05:29:46,193 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-21 05:29:46,506 unpacking tar archive at: mozilla-central-ecf9cc9bfca0/testing/mozharness/ program finished with exit code 0 elapsedTime=11.408744 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-08-21 05:29:45.941952) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 05:29:45.945291) ========= script_repo_revision: ecf9cc9bfca0853c22f7cf78a88b5762a002164e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 05:29:45.945656) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 05:29:45.945912) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 05:29:45.957745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-21 05:29:45.958041) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:29:47 INFO - MultiFileLogger online at 20170821 05:29:47 in /builds/slave/test 05:29:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:29:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:29:47 INFO - {'append_to_log': False, 05:29:47 INFO - 'base_work_dir': '/builds/slave/test', 05:29:47 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:29:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:29:47 INFO - 'branch': 'Firefox-Non-PGO', 05:29:47 INFO - 'buildbot_json_path': 'buildprops.json', 05:29:47 INFO - 'code_coverage': False, 05:29:47 INFO - 'config_files': ('talos/linux_config.py',), 05:29:47 INFO - 'default_actions': ('clobber', 05:29:47 INFO - 'read-buildbot-config', 05:29:47 INFO - 'download-and-extract', 05:29:47 INFO - 'populate-webroot', 05:29:47 INFO - 'create-virtualenv', 05:29:47 INFO - 'install', 05:29:47 INFO - 'setup-mitmproxy', 05:29:47 INFO - 'run-tests'), 05:29:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:29:47 INFO - 'disable_ccov_upload': False, 05:29:47 INFO - 'download_minidump_stackwalk': True, 05:29:47 INFO - 'download_symbols': 'ondemand', 05:29:47 INFO - 'enable_stylo': False, 05:29:47 INFO - 'enable_webrender': False, 05:29:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:29:47 INFO - 'tooltool.py': '/tools/tooltool.py', 05:29:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:29:47 INFO - '/tools/misc-python/virtualenv.py')}, 05:29:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:29:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:29:47 INFO - 'gecko_profile': False, 05:29:47 INFO - 'gecko_profile_interval': 0, 05:29:47 INFO - 'installer_path': 'installer.exe', 05:29:47 INFO - 'log_level': 'info', 05:29:47 INFO - 'log_name': 'talos', 05:29:47 INFO - 'log_to_console': True, 05:29:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:29:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:29:47 INFO - 'opt_config_files': (), 05:29:47 INFO - 'pip_index': False, 05:29:47 INFO - 'suite': 'dromaeojs-e10s', 05:29:47 INFO - 'system_bits': '32', 05:29:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:29:47 INFO - 'title': 'talos-linux64-ix-076', 05:29:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:29:47 INFO - 'use_talos_json': True, 05:29:47 INFO - 'verify': 'False', 05:29:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:29:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:29:47 INFO - 'work_dir': 'build'} 05:29:47 INFO - [mozharness: 2017-08-21 12:29:47.041206Z] Running clobber step. 05:29:47 INFO - Running pre-action listener: _resource_record_pre_action 05:29:47 INFO - Running main action method: clobber 05:29:47 INFO - rmtree: /builds/slave/test/build 05:29:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:29:48 INFO - Running post-action listener: _resource_record_post_action 05:29:48 INFO - [mozharness: 2017-08-21 12:29:48.064818Z] Finished clobber step (success) 05:29:48 INFO - [mozharness: 2017-08-21 12:29:48.064915Z] Running read-buildbot-config step. 05:29:48 INFO - Running pre-action listener: _resource_record_pre_action 05:29:48 INFO - Running main action method: read_buildbot_config 05:29:48 INFO - Using buildbot properties: 05:29:48 INFO - { 05:29:48 INFO - "project": "", 05:29:48 INFO - "product": "firefox", 05:29:48 INFO - "who": "archaeopteryx@coole-files.de", 05:29:48 INFO - "installer_path": "public/build/target.tar.bz2", 05:29:48 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:29:48 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:29:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:29:48 INFO - "stage_platform": "linux64", 05:29:48 INFO - "basedir": "/builds/slave/test", 05:29:48 INFO - "buildnumber": 781, 05:29:48 INFO - "platform": "ubuntu64_hw", 05:29:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:29:48 INFO - "slavebuilddir": "test", 05:29:48 INFO - "taskId": "H6vnVfi2TGCaasTKEvf_lA", 05:29:48 INFO - "branch": "mozilla-central", 05:29:48 INFO - "script_repo_revision": "production", 05:29:48 INFO - "revision": "ecf9cc9bfca0853c22f7cf78a88b5762a002164e", 05:29:48 INFO - "slavename": "talos-linux64-ix-076", 05:29:48 INFO - "repo_path": "mozilla-central" 05:29:48 INFO - } 05:29:48 INFO - Finding installer, test and symbols from parent task. 05:29:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H6vnVfi2TGCaasTKEvf_lA'}, attempt #1 05:29:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H6vnVfi2TGCaasTKEvf_lA'}, attempt #1 05:29:49 INFO - Task dependencies: GY_CFQtjQZGJCDtqe6SoTw 05:29:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw'}, attempt #1 05:29:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.tar.bz2 05:29:49 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.test_packages.json 05:29:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.crashreporter-symbols.zip 05:29:49 INFO - Running post-action listener: _resource_record_post_action 05:29:49 INFO - [mozharness: 2017-08-21 12:29:49.947415Z] Finished read-buildbot-config step (success) 05:29:49 INFO - [mozharness: 2017-08-21 12:29:49.947634Z] Running download-and-extract step. 05:29:49 INFO - Running pre-action listener: _resource_record_pre_action 05:29:49 INFO - Running main action method: download_and_extract 05:29:49 INFO - mkdir: /builds/slave/test/build/tests 05:29: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')]} 05:29:49 INFO - trying https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.test_packages.json 05:29:49 INFO - Downloading https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:29:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:29:50 INFO - Downloaded 989 bytes. 05:29:50 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:29:50 INFO - Using the following test package requirements: 05:29:50 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:29:50 INFO - u'common': [u'target.common.tests.zip'], 05:29:50 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:29:50 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:29:50 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:29:50 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:29:50 INFO - u'mozbase': [u'target.common.tests.zip'], 05:29:50 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:29:50 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:29:50 INFO - u'web-platform': [u'target.common.tests.zip', 05:29:50 INFO - u'target.web-platform.tests.tar.gz'], 05:29:50 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:29:50 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:29:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.common.tests.zip 05:29:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:29:50 INFO - Fetch https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.common.tests.zip into memory 05:29:52 INFO - Content-Length response header: 54005821 05:29:52 INFO - Bytes received: 54005821 05:30:03 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:30:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.common.tests.zip 05:30:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:30:03 INFO - Fetch https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.common.tests.zip into memory 05:30:05 INFO - Content-Length response header: 54005821 05:30:05 INFO - Bytes received: 54005821 05:30:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.talos.tests.zip 05:30:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:30:17 INFO - Fetch https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.talos.tests.zip into memory 05:30:18 INFO - Content-Length response header: 14496256 05:30:18 INFO - Bytes received: 14496256 05:30: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')]} 05:30:19 INFO - trying https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.tar.bz2 05:30:19 INFO - Downloading https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:30:22 INFO - Downloaded 62147803 bytes. 05:30:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.tar.bz2 05:30:22 INFO - mkdir: /builds/slave/test/properties 05:30:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:30:22 INFO - Writing to file /builds/slave/test/properties/build_url 05:30:22 INFO - Contents: 05:30:22 INFO - build_url:https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.tar.bz2 05:30:22 INFO - Running post-action listener: _resource_record_post_action 05:30:22 INFO - Running post-action listener: find_tests_for_verification 05:30:22 INFO - Running post-action listener: set_extra_try_arguments 05:30:22 INFO - [mozharness: 2017-08-21 12:30:22.976735Z] Finished download-and-extract step (success) 05:30:22 INFO - [mozharness: 2017-08-21 12:30:22.976963Z] Running populate-webroot step. 05:30:22 INFO - Running pre-action listener: _resource_record_pre_action 05:30:22 INFO - Running main action method: populate_webroot 05:30:22 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:30:22 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 05:30:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:30:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:30:22 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 05:30:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:30:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:30:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:22 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:30:22 INFO - 'talos_options': ['--stylo'], 05:30:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:30:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:30:22 INFO - 'tests': ['damp', 'tps']}, 05:30:22 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:30:22 INFO - 'talos_options': ['--stylo'], 05:30:22 INFO - 'tests': ['damp', 'tps']}, 05:30:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:30:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:30:22 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 05:30:22 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:30:22 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:30:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:30:22 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:30:22 INFO - 'talos_options': ['--stylo'], 05:30:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:30:22 INFO - 'other-e10s': {'tests': ['a11yr', 05:30:22 INFO - 'ts_paint', 05:30:22 INFO - 'tpaint', 05:30:22 INFO - 'sessionrestore', 05:30:22 INFO - 'sessionrestore_many_windows', 05:30:22 INFO - 'sessionrestore_no_auto_restore', 05:30:22 INFO - 'tabpaint']}, 05:30:22 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 05:30:22 INFO - 'tests': ['a11yr', 05:30:22 INFO - 'ts_paint', 05:30:22 INFO - 'tpaint', 05:30:22 INFO - 'sessionrestore', 05:30:22 INFO - 'sessionrestore_many_windows', 05:30:22 INFO - 'sessionrestore_no_auto_restore', 05:30:22 INFO - 'tabpaint']}, 05:30:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:30:22 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:30:22 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 05:30:22 INFO - 'tests': ['bloom_basic_singleton']}, 05:30:22 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 05:30:22 INFO - 'tests': ['bloom_basic']}, 05:30:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:30:22 INFO - 'tsvgr_opacity', 05:30:22 INFO - 'tart', 05:30:22 INFO - 'tscrollx', 05:30:22 INFO - 'tsvg_static']}, 05:30:22 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 05:30:22 INFO - 'tests': ['tsvgx', 05:30:22 INFO - 'tsvgr_opacity', 05:30:22 INFO - 'tart', 05:30:22 INFO - 'tscrollx', 05:30:22 INFO - 'tsvg_static']}, 05:30:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:30:22 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:30:22 INFO - 'talos_options': ['--stylo'], 05:30:22 INFO - 'tests': ['tp5o']}, 05:30:22 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:30:22 INFO - 'talos_options': ['--mitmproxy', 05:30:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:30:22 INFO - '--firstNonBlankPaint'], 05:30:22 INFO - 'tests': ['tp6_google', 05:30:22 INFO - 'tp6_youtube', 05:30:22 INFO - 'tp6_amazon', 05:30:22 INFO - 'tp6_facebook']}, 05:30:22 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:30:22 INFO - 'talos_options': ['--stylo', 05:30:22 INFO - '--mitmproxy', 05:30:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:30:22 INFO - '--firstNonBlankPaint'], 05:30:22 INFO - 'tests': ['tp6_google', 05:30:22 INFO - 'tp6_youtube', 05:30:22 INFO - 'tp6_amazon', 05:30:22 INFO - 'tp6_facebook']}, 05:30:22 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:30:22 INFO - 'talos_options': ['--stylo', 05:30:22 INFO - '--stylo-threads=1', 05:30:22 INFO - '--mitmproxy', 05:30:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:30:22 INFO - '--firstNonBlankPaint'], 05:30:22 INFO - 'tests': ['tp6_google', 05:30:22 INFO - 'tp6_youtube', 05:30:22 INFO - 'tp6_amazon', 05:30:22 INFO - 'tp6_facebook']}, 05:30:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:30:22 INFO - 'talos_options': ['--xperf_path', 05:30:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:22 INFO - 'tests': ['tp5n']}, 05:30:22 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 05:30:22 INFO - 'talos_options': ['--stylo', 05:30:22 INFO - '--xperf_path', 05:30:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:30:22 INFO - 'tests': ['tp5n']}}} 05:30:22 INFO - Running post-action listener: _resource_record_post_action 05:30:22 INFO - [mozharness: 2017-08-21 12:30:22.993297Z] Finished populate-webroot step (success) 05:30:22 INFO - [mozharness: 2017-08-21 12:30:22.993386Z] Running create-virtualenv step. 05:30:22 INFO - Running pre-action listener: _resource_record_pre_action 05:30:22 INFO - Running main action method: create_virtualenv 05:30:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:30:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:30:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:30:22 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:30:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:30:23 INFO - Using real prefix '/usr' 05:30:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:30:23 INFO - Installing distribute.............................................................................................................................................................................................done. 05:30:25 INFO - Installing pip.................done. 05:30:25 INFO - Return code: 0 05:30:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:30:25 INFO - Reading from file tmpfile_stdout 05:30:25 INFO - Output received: 05:30:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:30:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:30:25 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')]} 05:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:25 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')]} 05:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:25 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 0x1a721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dde130>, '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 0x1ddf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf4c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', '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 05:30:25 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 05:30:25 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 05:30:25 INFO - Using env: {'DISPLAY': ':0', 05:30:25 INFO - 'HOME': '/home/cltbld', 05:30:25 INFO - 'LANG': 'en_US.UTF-8', 05:30:25 INFO - 'LANGUAGE': 'en_US:en', 05:30:25 INFO - 'LOGNAME': 'cltbld', 05:30:25 INFO - 'MAIL': '/var/mail/cltbld', 05:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:25 INFO - 'MOZ_NO_REMOTE': '1', 05:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:25 INFO - 'NO_EM_RESTART': '1', 05:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:25 INFO - 'PWD': '/builds/slave/test', 05:30:25 INFO - 'SHELL': '/bin/bash', 05:30:25 INFO - 'SHLVL': '1', 05:30:25 INFO - 'TERM': 'linux', 05:30:25 INFO - 'TMOUT': '86400', 05:30:25 INFO - 'USER': 'cltbld', 05:30:25 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', 05:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:25 INFO - '_': '/tools/buildbot/bin/python'} 05:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:30:25 INFO - Cleaning up... 05:30:25 INFO - Return code: 0 05:30:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:30:25 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')]} 05:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:25 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')]} 05:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:25 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 0x1a721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dde130>, '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 0x1ddf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf4c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', '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 05:30:25 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 05:30:25 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 05:30:26 INFO - Using env: {'DISPLAY': ':0', 05:30:26 INFO - 'HOME': '/home/cltbld', 05:30:26 INFO - 'LANG': 'en_US.UTF-8', 05:30:26 INFO - 'LANGUAGE': 'en_US:en', 05:30:26 INFO - 'LOGNAME': 'cltbld', 05:30:26 INFO - 'MAIL': '/var/mail/cltbld', 05:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:26 INFO - 'MOZ_NO_REMOTE': '1', 05:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:26 INFO - 'NO_EM_RESTART': '1', 05:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:26 INFO - 'PWD': '/builds/slave/test', 05:30:26 INFO - 'SHELL': '/bin/bash', 05:30:26 INFO - 'SHLVL': '1', 05:30:26 INFO - 'TERM': 'linux', 05:30:26 INFO - 'TMOUT': '86400', 05:30:26 INFO - 'USER': 'cltbld', 05:30:26 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', 05:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:26 INFO - '_': '/tools/buildbot/bin/python'} 05:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:26 INFO - Downloading/unpacking psutil>=3.1.1 05:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:30:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:27 INFO - Installing collected packages: psutil 05:30:27 INFO - Running setup.py install for psutil 05:30:27 INFO - building 'psutil._psutil_linux' extension 05:30:27 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 05:30:27 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 05:30:27 INFO - building 'psutil._psutil_posix' extension 05:30:27 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 05:30:27 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 05:30:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:30:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:30:27 INFO - Successfully installed psutil 05:30:27 INFO - Cleaning up... 05:30:27 INFO - Return code: 0 05:30:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:30: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')]} 05:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30: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')]} 05:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:27 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 0x1a721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dde130>, '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 0x1ddf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf4c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', '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 05:30:27 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 05:30:27 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 05:30:27 INFO - Using env: {'DISPLAY': ':0', 05:30:27 INFO - 'HOME': '/home/cltbld', 05:30:27 INFO - 'LANG': 'en_US.UTF-8', 05:30:27 INFO - 'LANGUAGE': 'en_US:en', 05:30:27 INFO - 'LOGNAME': 'cltbld', 05:30:27 INFO - 'MAIL': '/var/mail/cltbld', 05:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:27 INFO - 'MOZ_NO_REMOTE': '1', 05:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:27 INFO - 'NO_EM_RESTART': '1', 05:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:27 INFO - 'PWD': '/builds/slave/test', 05:30:27 INFO - 'SHELL': '/bin/bash', 05:30:27 INFO - 'SHLVL': '1', 05:30:27 INFO - 'TERM': 'linux', 05:30:27 INFO - 'TMOUT': '86400', 05:30:27 INFO - 'USER': 'cltbld', 05:30:27 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', 05:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:27 INFO - '_': '/tools/buildbot/bin/python'} 05:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:30: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 05:30: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 05:30: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 05:30: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 05:30:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:30:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:30:29 INFO - Installing collected packages: mozsystemmonitor 05:30:29 INFO - Running setup.py install for mozsystemmonitor 05:30:29 INFO - Successfully installed mozsystemmonitor 05:30:29 INFO - Cleaning up... 05:30:29 INFO - Return code: 0 05:30:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dde130>, '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 0x1ddf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf4c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', '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 05:30:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:30:29 INFO - Using env: {'DISPLAY': ':0', 05:30:29 INFO - 'HOME': '/home/cltbld', 05:30:29 INFO - 'LANG': 'en_US.UTF-8', 05:30:29 INFO - 'LANGUAGE': 'en_US:en', 05:30:29 INFO - 'LOGNAME': 'cltbld', 05:30:29 INFO - 'MAIL': '/var/mail/cltbld', 05:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:29 INFO - 'MOZ_NO_REMOTE': '1', 05:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:29 INFO - 'NO_EM_RESTART': '1', 05:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:29 INFO - 'PWD': '/builds/slave/test', 05:30:29 INFO - 'SHELL': '/bin/bash', 05:30:29 INFO - 'SHLVL': '1', 05:30:29 INFO - 'TERM': 'linux', 05:30:29 INFO - 'TMOUT': '86400', 05:30:29 INFO - 'USER': 'cltbld', 05:30:29 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', 05:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:29 INFO - '_': '/tools/buildbot/bin/python'} 05:30:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:29 INFO - Downloading/unpacking jsonschema==2.5.1 05:30:29 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 05:30:29 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 05:30:29 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 05:30:29 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 05:30:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:30:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:30: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 05:30: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 05:30: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 05:30: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 05:30:31 INFO - Downloading functools32-3.2.3-2.tar.gz 05:30:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:30:31 INFO - warning: no files found matching '*.txt' 05:30:31 INFO - no previously-included directories found matching 'build' 05:30:31 INFO - no previously-included directories found matching 'dist' 05:30:31 INFO - no previously-included directories found matching '.git*' 05:30:31 INFO - Installing collected packages: jsonschema, functools32 05:30:31 INFO - Running setup.py install for functools32 05:30:31 INFO - warning: no files found matching '*.txt' 05:30:31 INFO - no previously-included directories found matching 'build' 05:30:31 INFO - no previously-included directories found matching 'dist' 05:30:31 INFO - no previously-included directories found matching '.git*' 05:30:31 INFO - Successfully installed jsonschema functools32 05:30:31 INFO - Cleaning up... 05:30:31 INFO - Return code: 0 05:30:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:31 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 0x1a721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dde130>, '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 0x1ddf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf4c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', '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 05:30:31 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 05:30:31 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 05:30:31 INFO - Using env: {'DISPLAY': ':0', 05:30:31 INFO - 'HOME': '/home/cltbld', 05:30:31 INFO - 'LANG': 'en_US.UTF-8', 05:30:31 INFO - 'LANGUAGE': 'en_US:en', 05:30:31 INFO - 'LOGNAME': 'cltbld', 05:30:31 INFO - 'MAIL': '/var/mail/cltbld', 05:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:31 INFO - 'MOZ_NO_REMOTE': '1', 05:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:31 INFO - 'NO_EM_RESTART': '1', 05:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:31 INFO - 'PWD': '/builds/slave/test', 05:30:31 INFO - 'SHELL': '/bin/bash', 05:30:31 INFO - 'SHLVL': '1', 05:30:31 INFO - 'TERM': 'linux', 05:30:31 INFO - 'TMOUT': '86400', 05:30:31 INFO - 'USER': 'cltbld', 05:30:31 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', 05:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:31 INFO - '_': '/tools/buildbot/bin/python'} 05:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:30:31 INFO - Cleaning up... 05:30:31 INFO - Return code: 0 05:30:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:31 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 0x1a721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dde130>, '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 0x1ddf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf4c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', '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 05:30:31 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 05:30:31 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 05:30:31 INFO - Using env: {'DISPLAY': ':0', 05:30:31 INFO - 'HOME': '/home/cltbld', 05:30:31 INFO - 'LANG': 'en_US.UTF-8', 05:30:31 INFO - 'LANGUAGE': 'en_US:en', 05:30:31 INFO - 'LOGNAME': 'cltbld', 05:30:31 INFO - 'MAIL': '/var/mail/cltbld', 05:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:31 INFO - 'MOZ_NO_REMOTE': '1', 05:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:31 INFO - 'NO_EM_RESTART': '1', 05:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:31 INFO - 'PWD': '/builds/slave/test', 05:30:31 INFO - 'SHELL': '/bin/bash', 05:30:31 INFO - 'SHLVL': '1', 05:30:31 INFO - 'TERM': 'linux', 05:30:31 INFO - 'TMOUT': '86400', 05:30:31 INFO - 'USER': 'cltbld', 05:30:31 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', 05:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:31 INFO - '_': '/tools/buildbot/bin/python'} 05:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:31 INFO - Downloading/unpacking blobuploader==1.2.4 05:30:31 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 05:30:31 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 05:30:31 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 05:30:31 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 05:30:32 INFO - Downloading blobuploader-1.2.4.tar.gz 05:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:30:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:30:32 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 05:30:32 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 05:30:32 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 05:30:32 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 05:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:30:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:30:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:30:33 INFO - Downloading docopt-0.6.1.tar.gz 05:30:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:30:33 INFO - Installing collected packages: blobuploader, requests, docopt 05:30:33 INFO - Running setup.py install for blobuploader 05:30:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:30:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:30:33 INFO - Running setup.py install for requests 05:30:33 INFO - Running setup.py install for docopt 05:30:34 INFO - Successfully installed blobuploader requests docopt 05:30:34 INFO - Cleaning up... 05:30:34 INFO - Return code: 0 05:30:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:34 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 0x1a721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dde130>, '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 0x1ddf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf4c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', '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 05:30:34 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 05:30:34 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 05:30:34 INFO - Using env: {'DISPLAY': ':0', 05:30:34 INFO - 'HOME': '/home/cltbld', 05:30:34 INFO - 'LANG': 'en_US.UTF-8', 05:30:34 INFO - 'LANGUAGE': 'en_US:en', 05:30:34 INFO - 'LOGNAME': 'cltbld', 05:30:34 INFO - 'MAIL': '/var/mail/cltbld', 05:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:34 INFO - 'MOZ_NO_REMOTE': '1', 05:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:34 INFO - 'NO_EM_RESTART': '1', 05:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:34 INFO - 'PWD': '/builds/slave/test', 05:30:34 INFO - 'SHELL': '/bin/bash', 05:30:34 INFO - 'SHLVL': '1', 05:30:34 INFO - 'TERM': 'linux', 05:30:34 INFO - 'TMOUT': '86400', 05:30:34 INFO - 'USER': 'cltbld', 05:30:34 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', 05:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:34 INFO - '_': '/tools/buildbot/bin/python'} 05:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:34 INFO - Running setup.py (path:/tmp/pip-SEg8wu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:34 INFO - Running setup.py (path:/tmp/pip-HWRDv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:34 INFO - Running setup.py (path:/tmp/pip-_TnttJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:34 INFO - Running setup.py (path:/tmp/pip-qnj1Z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:34 INFO - Running setup.py (path:/tmp/pip-7i2_jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:34 INFO - Running setup.py (path:/tmp/pip-Ze6zE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:34 INFO - Running setup.py (path:/tmp/pip-TUu7Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:34 INFO - Running setup.py (path:/tmp/pip-Xnvt_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:34 INFO - Running setup.py (path:/tmp/pip-ZvT8Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:34 INFO - Running setup.py (path:/tmp/pip-vBVWQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:35 INFO - Running setup.py (path:/tmp/pip-Letd8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:35 INFO - Running setup.py (path:/tmp/pip-HZCBG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:35 INFO - Running setup.py (path:/tmp/pip-vm84M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:35 INFO - Running setup.py (path:/tmp/pip-DIEDMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:35 INFO - Running setup.py (path:/tmp/pip-XTjmha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:35 INFO - Running setup.py (path:/tmp/pip-XsUqiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:35 INFO - Running setup.py (path:/tmp/pip-24Q4Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:30:35 INFO - Running setup.py install for manifestparser 05:30:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:30:35 INFO - Running setup.py install for mozcrash 05:30:35 INFO - Running setup.py install for mozdebug 05:30:35 INFO - Running setup.py install for mozdevice 05:30:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:30:35 INFO - Running setup.py install for mozfile 05:30:36 INFO - Running setup.py install for mozhttpd 05:30:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:30:36 INFO - Running setup.py install for mozinfo 05:30:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:30:36 INFO - Running setup.py install for mozInstall 05:30:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:30:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:30:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:30:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:30:36 INFO - Running setup.py install for mozleak 05:30:36 INFO - Running setup.py install for mozlog 05:30:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:30:36 INFO - Running setup.py install for moznetwork 05:30:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:30:36 INFO - Running setup.py install for mozprocess 05:30:36 INFO - Running setup.py install for mozprofile 05:30:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:30:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:30:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:30:36 INFO - Running setup.py install for mozrunner 05:30:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:30:36 INFO - Running setup.py install for mozscreenshot 05:30:37 INFO - Running setup.py install for moztest 05:30:37 INFO - Running setup.py install for mozversion 05:30:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:30:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:30:37 INFO - Cleaning up... 05:30:37 INFO - Return code: 0 05:30:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:37 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 0x1a721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dde130>, '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 0x1ddf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf4c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', '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 05:30:37 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 05:30:37 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 05:30:37 INFO - Using env: {'DISPLAY': ':0', 05:30:37 INFO - 'HOME': '/home/cltbld', 05:30:37 INFO - 'LANG': 'en_US.UTF-8', 05:30:37 INFO - 'LANGUAGE': 'en_US:en', 05:30:37 INFO - 'LOGNAME': 'cltbld', 05:30:37 INFO - 'MAIL': '/var/mail/cltbld', 05:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:37 INFO - 'MOZ_NO_REMOTE': '1', 05:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:37 INFO - 'NO_EM_RESTART': '1', 05:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:37 INFO - 'PWD': '/builds/slave/test', 05:30:37 INFO - 'SHELL': '/bin/bash', 05:30:37 INFO - 'SHLVL': '1', 05:30:37 INFO - 'TERM': 'linux', 05:30:37 INFO - 'TMOUT': '86400', 05:30:37 INFO - 'USER': 'cltbld', 05:30:37 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', 05:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:37 INFO - '_': '/tools/buildbot/bin/python'} 05:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:30:37 INFO - Running setup.py (path:/tmp/pip-YY2Q5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:30:37 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)) 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:30:37 INFO - Running setup.py (path:/tmp/pip-EdThmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:30:37 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)) 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:30:37 INFO - Running setup.py (path:/tmp/pip-dG5PKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:30:37 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)) 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:30:37 INFO - Running setup.py (path:/tmp/pip-zutDm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:30:37 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)) 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:30:37 INFO - Running setup.py (path:/tmp/pip-zItrYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:30:37 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)) 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:30:37 INFO - Running setup.py (path:/tmp/pip-3Woqms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:30:37 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)) 05:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:30:37 INFO - Running setup.py (path:/tmp/pip-7sSI7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:30:38 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)) 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:30:38 INFO - Running setup.py (path:/tmp/pip-EOQwFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:30:38 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)) 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:30:38 INFO - Running setup.py (path:/tmp/pip-76gieW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:30:38 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)) 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:30:38 INFO - Running setup.py (path:/tmp/pip-WMH3jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:30:38 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)) 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:30:38 INFO - Running setup.py (path:/tmp/pip-wg3Pu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:30:38 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)) 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:30:38 INFO - Running setup.py (path:/tmp/pip-quZdeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:30:38 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)) 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:30:38 INFO - Running setup.py (path:/tmp/pip-bWh2aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:30:38 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)) 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:30:38 INFO - Running setup.py (path:/tmp/pip-Llf1ZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:30:38 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)) 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:38 INFO - Running setup.py (path:/tmp/pip-UL5gko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:30:38 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)) 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:30:38 INFO - Running setup.py (path:/tmp/pip-d972Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:30:38 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)) 05:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:30:38 INFO - Running setup.py (path:/tmp/pip-uDOZjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:30:38 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)) 05:30:38 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)) 05:30:38 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)) 05:30:38 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)) 05:30:38 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)) 05:30:38 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)) 05:30:38 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)) 05:30:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:30:38 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 05:30:38 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 05:30:38 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 05:30:38 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 05:30:39 INFO - Downloading blessings-1.6.tar.gz 05:30:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:30:39 INFO - Installing collected packages: blessings 05:30:39 INFO - Running setup.py install for blessings 05:30:40 INFO - Successfully installed blessings 05:30:40 INFO - Cleaning up... 05:30:40 INFO - Return code: 0 05:30:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:30:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:40 INFO - Reading from file tmpfile_stdout 05:30:40 INFO - Current package versions: 05:30:40 INFO - argparse == 1.2.1 05:30:40 INFO - blessings == 1.6 05:30:40 INFO - blobuploader == 1.2.4 05:30:40 INFO - docopt == 0.6.1 05:30:40 INFO - functools32 == 3.2.3-2 05:30:40 INFO - jsonschema == 2.5.1 05:30:40 INFO - manifestparser == 1.1 05:30:40 INFO - mozInstall == 1.13 05:30:40 INFO - mozcrash == 1.0 05:30:40 INFO - mozdebug == 0.1 05:30:40 INFO - mozdevice == 0.51 05:30:40 INFO - mozfile == 1.2 05:30:40 INFO - mozhttpd == 0.7 05:30:40 INFO - mozinfo == 0.10 05:30:40 INFO - mozleak == 0.1 05:30:40 INFO - mozlog == 3.5 05:30:40 INFO - moznetwork == 0.27 05:30:40 INFO - mozprocess == 0.25 05:30:40 INFO - mozprofile == 0.28 05:30:40 INFO - mozrunner == 6.13 05:30:40 INFO - mozscreenshot == 0.1 05:30:40 INFO - mozsystemmonitor == 0.3 05:30:40 INFO - moztest == 0.8 05:30:40 INFO - mozversion == 1.4 05:30:40 INFO - psutil == 3.1.1 05:30:40 INFO - requests == 1.2.3 05:30:40 INFO - wsgiref == 0.1.2 05:30:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:30:40 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')]} 05:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:40 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')]} 05:30:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:40 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 0x1a721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dde130>, '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 0x1ddf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf4c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', '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 05:30:40 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 05:30:40 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 05:30:40 INFO - Using env: {'DISPLAY': ':0', 05:30:40 INFO - 'HOME': '/home/cltbld', 05:30:40 INFO - 'LANG': 'en_US.UTF-8', 05:30:40 INFO - 'LANGUAGE': 'en_US:en', 05:30:40 INFO - 'LOGNAME': 'cltbld', 05:30:40 INFO - 'MAIL': '/var/mail/cltbld', 05:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:40 INFO - 'MOZ_NO_REMOTE': '1', 05:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:40 INFO - 'NO_EM_RESTART': '1', 05:30:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:40 INFO - 'PWD': '/builds/slave/test', 05:30:40 INFO - 'SHELL': '/bin/bash', 05:30:40 INFO - 'SHLVL': '1', 05:30:40 INFO - 'TERM': 'linux', 05:30:40 INFO - 'TMOUT': '86400', 05:30:40 INFO - 'USER': 'cltbld', 05:30:40 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', 05:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:40 INFO - '_': '/tools/buildbot/bin/python'} 05:30:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:40 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)) 05:30:40 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)) 05:30:40 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)) 05:30:40 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)) 05:30:40 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)) 05:30:40 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)) 05:30:40 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)) 05:30:40 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)) 05:30:40 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)) 05:30:40 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:30:40 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 05:30:40 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 05:30:40 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 05:30:40 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 05:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:30:41 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)) 05:30:41 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)) 05:30:41 INFO - Installing collected packages: simplejson 05:30:41 INFO - Running setup.py install for simplejson 05:30:41 INFO - building 'simplejson._speedups' extension 05:30:41 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 05:30:42 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 05:30:42 INFO - Successfully installed simplejson 05:30:42 INFO - Cleaning up... 05:30:42 INFO - Return code: 0 05:30:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:30:42 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')]} 05:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:30:42 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')]} 05:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:30:42 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 0x1a721f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1de0f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dde130>, '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 0x1ddf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf4c0>, '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': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', '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 05:30:42 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 05:30:42 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 05:30:42 INFO - Using env: {'DISPLAY': ':0', 05:30:42 INFO - 'HOME': '/home/cltbld', 05:30:42 INFO - 'LANG': 'en_US.UTF-8', 05:30:42 INFO - 'LANGUAGE': 'en_US:en', 05:30:42 INFO - 'LOGNAME': 'cltbld', 05:30:42 INFO - 'MAIL': '/var/mail/cltbld', 05:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:30:42 INFO - 'MOZ_NO_REMOTE': '1', 05:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:30:42 INFO - 'NO_EM_RESTART': '1', 05:30:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:30:42 INFO - 'PWD': '/builds/slave/test', 05:30:42 INFO - 'SHELL': '/bin/bash', 05:30:42 INFO - 'SHLVL': '1', 05:30:42 INFO - 'TERM': 'linux', 05:30:42 INFO - 'TMOUT': '86400', 05:30:42 INFO - 'USER': 'cltbld', 05:30:42 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', 05:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:30:42 INFO - '_': '/tools/buildbot/bin/python'} 05:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:30:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:30:42 INFO - Cleaning up... 05:30:42 INFO - Return code: 0 05:30:42 INFO - Running post-action listener: _resource_record_post_action 05:30:42 INFO - Running post-action listener: _start_resource_monitoring 05:30:43 INFO - Starting resource monitoring. 05:30:43 INFO - [mozharness: 2017-08-21 12:30:43.012079Z] Finished create-virtualenv step (success) 05:30:43 INFO - [mozharness: 2017-08-21 12:30:43.012639Z] Running install step. 05:30:43 INFO - Running pre-action listener: _resource_record_pre_action 05:30:43 INFO - Running main action method: install 05:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:30:43 INFO - Reading from file tmpfile_stdout 05:30:43 INFO - Detecting whether we're running mozinstall >=1.0... 05:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:30:43 INFO - Reading from file tmpfile_stdout 05:30:43 INFO - Output received: 05:30:43 INFO - Usage: mozinstall [options] installer 05:30:43 INFO - Options: 05:30:43 INFO - -h, --help show this help message and exit 05:30:43 INFO - -d DEST, --destination=DEST 05:30:43 INFO - Directory to install application into. [default: 05:30:43 INFO - "/builds/slave/test"] 05:30:43 INFO - --app=APP Application being installed. [default: firefox] 05:30:43 INFO - mkdir: /builds/slave/test/build/application 05:30:43 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'] 05:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:31:01 INFO - Reading from file tmpfile_stdout 05:31:01 INFO - Output received: 05:31:01 INFO - /builds/slave/test/build/application/firefox/firefox 05:31:01 INFO - Running post-action listener: _resource_record_post_action 05:31:01 INFO - [mozharness: 2017-08-21 12:31:01.393038Z] Finished install step (success) 05:31:01 INFO - [mozharness: 2017-08-21 12:31:01.393322Z] Running setup-mitmproxy step. 05:31:01 INFO - Running pre-action listener: _resource_record_pre_action 05:31:01 INFO - Running main action method: setup_mitmproxy 05:31:01 INFO - Skipping: mitmproxy is not required 05:31:01 INFO - Running post-action listener: _resource_record_post_action 05:31:01 INFO - [mozharness: 2017-08-21 12:31:01.394455Z] Finished setup-mitmproxy step (success) 05:31:01 INFO - [mozharness: 2017-08-21 12:31:01.394672Z] Running run-tests step. 05:31:01 INFO - Running pre-action listener: _resource_record_pre_action 05:31:01 INFO - Running pre-action listener: _set_gcov_prefix 05:31:01 INFO - Running main action method: run_tests 05:31:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:31:01 INFO - Python 2.7.3 05:31:01 INFO - Return code: 0 05:31:01 INFO - grabbing minidump binary from tooltool 05:31:01 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')]} 05:31:01 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x1dde130>, '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 0x1ddf030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ddf4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:31:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 05:31:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:31:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 05:31:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:31:01 INFO - Return code: 0 05:31:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:31:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:31:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:31:01 INFO - ENV: RUST_BACKTRACE is now full 05:31:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:31:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:31:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 05:31:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 05:31:01 INFO - Using env: {'DISPLAY': ':0', 05:31:01 INFO - 'HOME': '/home/cltbld', 05:31:01 INFO - 'LANG': 'en_US.UTF-8', 05:31:01 INFO - 'LANGUAGE': 'en_US:en', 05:31:01 INFO - 'LOGNAME': 'cltbld', 05:31:01 INFO - 'MAIL': '/var/mail/cltbld', 05:31:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:31:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:01 INFO - 'MOZ_NO_REMOTE': '1', 05:31:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:31:01 INFO - 'NO_EM_RESTART': '1', 05:31:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:01 INFO - 'PWD': '/builds/slave/test', 05:31:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:31:01 INFO - 'RUST_BACKTRACE': 'full', 05:31:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:31:01 INFO - 'SHELL': '/bin/bash', 05:31:01 INFO - 'SHLVL': '1', 05:31:01 INFO - 'TERM': 'linux', 05:31:01 INFO - 'TMOUT': '86400', 05:31:01 INFO - 'USER': 'cltbld', 05:31:01 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319', 05:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:01 INFO - '_': '/tools/buildbot/bin/python'} 05:31:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 05:31:01 INFO - mozversion application_buildid: 20170821114050 05:31:01 INFO - mozversion application_changeset: ecf9cc9bfca0853c22f7cf78a88b5762a002164e 05:31:01 INFO - mozversion application_display_name: Nightly 05:31:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:31:01 INFO - mozversion application_name: Firefox 05:31:01 INFO - mozversion application_remotingname: firefox 05:31:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:31:01 INFO - mozversion application_vendor: Mozilla 05:31:01 INFO - mozversion application_version: 57.0a1 05:31:01 INFO - mozversion platform_buildid: 20170821114050 05:31:01 INFO - mozversion platform_changeset: ecf9cc9bfca0853c22f7cf78a88b5762a002164e 05:31:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:31:01 INFO - mozversion platform_version: 57.0a1 05:31:01 INFO - using testdate: 1503318661 05:31:01 INFO - actual date: 1503318661 05:31:01 INFO - starting webserver on 'localhost:60128' 05:31:01 INFO - SUITE-START | Running 2 tests 05:31:01 INFO - TEST-START | dromaeo_css 05:31:01 INFO - Initialising browser for dromaeo_css test... 05:31:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60128/getInfo.html -profile /tmp/tmp1sNrQc/profile 05:31:01 INFO - TEST-INFO | started process 6280 (/builds/slave/test/build/application/firefox/firefox http://localhost:60128/getInfo.html) 05:31:07 INFO - TEST-INFO | 6280: exit 0 05:31:07 INFO - Browser initialized. 05:31:07 INFO - Running cycle 1/1 for dromaeo_css test... 05:31:07 INFO - TEST-INFO | started process 6456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1sNrQc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:08 INFO - PID 6456 | 05:31:08 INFO - PID 6456 | (/builds/slave/test/build/application/firefox/firefox:6505): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:31:08 INFO - PID 6456 | 05:31:09 INFO - PID 6456 | 05:31:09 INFO - PID 6456 | (/builds/slave/test/build/application/firefox/firefox:6557): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:31:09 INFO - PID 6456 | 05:31:09 INFO - PID 6456 | __metrics Screen width/height:1600/1200 05:31:09 INFO - PID 6456 | colorDepth:24 05:31:09 INFO - PID 6456 | Browser inner width/height: 1024/768 05:31:09 INFO - PID 6456 | __metrics 05:31:19 INFO - PID 6456 | RSS: Main: 171991040 05:31:19 INFO - PID 6456 | 05:34:18 INFO - PID 6456 | Cycle 1(1): loaded http://localhost:60128/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60128/tests/dromaeo/cssquery-ext.html) 05:34:19 INFO - PID 6456 | RSS: Main: 174866432 05:34:19 INFO - PID 6456 | 05:37:20 INFO - PID 6456 | Cycle 1(1): loaded http://localhost:60128/tests/dromaeo/cssquery-ext.html (next: http://localhost:60128/tests/dromaeo/cssquery-jquery.html) 05:37:21 INFO - PID 6456 | RSS: Main: 171876352 05:37:21 INFO - PID 6456 | 05:40:23 INFO - PID 6456 | Cycle 1(1): loaded http://localhost:60128/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60128/tests/dromaeo/cssquery-mootools.html) 05:40:23 INFO - PID 6456 | RSS: Main: 174858240 05:40:23 INFO - PID 6456 | 05:43:25 INFO - PID 6456 | Cycle 1(1): loaded http://localhost:60128/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60128/tests/dromaeo/cssquery-prototype.html) 05:43:26 INFO - PID 6456 | RSS: Main: 171507712 05:43:26 INFO - PID 6456 | 05:46:29 INFO - PID 6456 | Cycle 1(1): loaded http://localhost:60128/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60128/tests/dromaeo/cssquery-yui.html) 05:46:30 INFO - PID 6456 | RSS: Main: 176713728 05:46:30 INFO - PID 6456 | 05:49:32 INFO - PID 6456 | Cycle 1(1): loaded http://localhost:60128/tests/dromaeo/cssquery-yui.html (next: http://localhost:60128/tests/dromaeo/cssquery-dojo.html) 05:49:32 INFO - PID 6456 | RSS: Main: 175652864 05:49:32 INFO - PID 6456 | 05:49:32 INFO - PID 6456 | __start_tp_report 05:49:32 INFO - PID 6456 | _x_x_mozilla_page_load 05:49:32 INFO - PID 6456 | _x_x_mozilla_page_load_details 05:49:32 INFO - PID 6456 | |i|pagename|runs| 05:49:32 INFO - PID 6456 | |0;dojo.html;3172.5717028201184;3173.5398367236735;3174.1112488503218;3182.6817318268168;3224.822634755089;6162.291336496304;6214.409631085051;6248.250209974809;6268;6304.117423560694;6153.35389784073;6236.251649802019;6253.906191407133;6257.5619706620555;6267.341929097447;5674.687892165929;5675.091985282366;5771.913421298684;5792.131180322943;5803.709814509279;5625.943740562603;5741.167530708045;5754.223179870727;5781.364049954502;5812.0410132328325;5533.170024496338;5651.519620832193;5655.745491452874;5739.426057394227;5745.913811292834;5696.943030569682;5709.115087161496;5758.280214973129;5762.279715035621;5772.595918285721;5543.750531226105;5618.073017952033;5674.829755107354;5724.141378793172;5729.255196824428;6173.228346456693;6224.533160012972;6227.439530442237;6246;6252.124702541648;6671.432928201109;6678.1986161660425;6753.898691519631;6777.288384719632;6785.864282714368;6586;6746.359095885883;6774.424173945221;6859.31406859315;6861.622610756406;6201.100840378165;6239.157713708682;6245.937540624626;6255.4057364549835;6272.090546870678;6886.690098945459;6958.095447591882;6971.407430368374;6974.093367862146;7004.719811207597;6450.903236451457;6552.115464412243;6578.473722102221;6652.401283884474;6667.133272674619;6485.092087107809;6578.769743059066;6681.498887583451;6756.391924726799;6763.492738044666;6716.059751634775;6724.697388617426;6730.9326906731285;6755.932440675629;6761.898571521431;6683.465322774166;6687.130673012477;6752.020956961312;6753.49348798842;6780.694868730919;5423.3491980962535;5452.59105567084;5519.061759500894;5523.530499907552;5523.558115350843;4617.676762626584;4621.60716339115;4652.302154676758;4654.138984287918;4667.509911459316;5762.30852297727;5838.065909454467;5842.211301474246;5848.678322692293;5856.150858125633;6656.101426307387;6763.357481039294;6816.113905192393;6843.349881761224;6866.725330986805;5664.51851592611;5787;5865.560082993792;5880.617759845596;5896.056630939029;5893.5579831512805;5917.911231331534;5927.436893495111;5987.491063259585;5992.370801065913;6365;6490.675466226669;6585.308542603054;6585.934140658628;6592.439642630334;6619.536632435876;6710.798676039727;6733.46132309414;6766.086578311865;6768.7292508299115;6480.092787009728;6508.544401892012;6513.478921686348;6532;6532.379423954717;6599.7360105595235;6607.867842643024;6616.2060552732055;6623.105880706235;6682.933170668425;6790.830229244309;6829.863402732017;6833.214180369321;6842.315768423317;6848.3494068063455;6503.25212600557;6539.6403197824575;6602.141721576164;6606.8017959461295;6608.140941677551;6402.935970640234;6488.448481879093;6502.317256687979;6510.5117116217425;6588.308227636221;6525.0538671893255;6551.377619126175;6563.212414510289;6568.1789776277965;6591.703373348307;6597.109390232257;6620.635865027277;6699.8325041872395;6703;6712.597244165366;6280.466160376236;6384.553081284265;6397.616143031433;6400.103985442135;6485.77299794505 05:49:32 INFO - PID 6456 | |1;ext.html;797.6211299632672;858.2104463893218;886.0253720907003;1185.1703807334861;1205.3129716061849;30895;43199.35200971988;43772.56227437725;43791;43808.78095609517;43477;43900.780496097475;43992.3401148983;43992.3401148983;44022.77988610052;7637.274458926393;7740.961295193544;7776.80557986052;7779.8833017504785;7782.883256751125;7689.538627682329;7786.3381612563;7797.103333116707;7798.2981531662135;7800.141984381742;7243.601601911892;7416.962915185417;7811.687532498721;7816.140224575321;7816.53100813953;7693.346065584432;7756.069271687434;7756.418268629847;7757.379409647215;7760.534367937914;7642.694292228304;7734.226577342277;7739.651715672809;7740.303372696484;7743.225677432268;39670;39799;39869.80065099685;39894.20211595781;39927.20145597101;3578.2664553766417;3624.6375362463805;3625.23869987303;3627.4196128619296;3637.763545369569;32080;32173.195670108435;32179.06925584449;32242.516362254584;32305.1923701907;4893.535114164149;5061.822836200715;5116.258142569344;5122.052420302219;5210.166373380241;198952;199600;200643;201456;201463;47394.289085663746;47445.288320675216;47457.762711186224;47597.52402476;47631.57105286847;50832;50844.23733643998;50941.49058509368;51006.489935100915;51033.234501482504;16273.593160170854;16706.83293167077;16718.41485548;16722.080285584165;16776.66446671084;13732.725345493034;13765.518206862711;13765.587032389045;13791.655208619664;13808.861911380958;13041.087123901425;14757.631059223606;14858.554243372717;14913.030653007736;14944.327505262288;5230.37235531731;5917.142014407973;5968.671723055187;5987.43119403656;6264.937350626436;991.2664628175098;1007.9092881640687;1019.7628852119456;1033.0857191385528;1034.6275340877278;23098.53802923932;23477;23646;23665.053397863892;23824;1117.044926587772;1117.1788735279563;1127.7124333295121;1134.0020781712205;1135.3074624479061;12492.437840297209;12523.686907827196;12547.93726031364;12555;12642.55751048709;233742;234523;236356;236741;236956;53404.465955340725;53422;53580.73209634005;53836;53891.46108538943;1446.3708286895235;1459.7080583883267;1489.0544504239886;1498.6178524476188;1509.056839475328;22641;22693.546129077655;22895.656565151203;23054.308370748906;23227;37765.62234377731;37889.43165852459;37907.241855163295;37924.62075379211;37944;195378;195927;196096;196369;196416;35214;35269.64730352664;35302.64697352993;35545.64454355527;35597.110072248404;39260.80369598134;39773;39860.40209396919;42251.7887410561;45014.0997180048;25087.247382578553;31295;32607.510887337183;35576.822115889256;35944.10139746423;34870;35252.47121293131;36008.4598731014;36306.818465907505;36356.27287454289;39054.4141837867;39063.41404878986;39248.80375598104;39335.40996885106;39575;34615.13462163466;35057.82471087628;35126.473102902964;35127.64872351346;35185;23231.53536929286;24184.395390115387;24983;25119.372015699755;25464.872675636503 05:49:32 INFO - PID 6456 | |2;jquery.html;554.8668319603294;566.365670449097;571.6827160925687;572.4075581772865;582.1297160744687;22882;23745.643815342784;23754.16860409886;23759.524809503822;23762.524749505;25223;27664.308392290204;27674.861625691843;27748.306292342702;27867.581986270223;6668.266490686021;6804.931950680504;6827.829304267383;6834.21406538247;6836.726530938757;6612.801615951529;6629.303923088079;6672.499562532806;6927.618980956046;6957.269486703899;6934.687939042755;6944.375006249436;6950.478714096438;6955.443564514852;6957.095577574908;6934.410575101122;6935.029095926574;6937.549059311179;6939.0979172707475;6939.618320992344;6782.966085169592;6786.830329241809;6810.387065164109;6819.795406137824;6833.58998460089;32177.51733723996;32450.02649920506;32846.67153328484;33019.17452063718;33174.17064573381;1930.5173706573357;1978.64384410806;1993.8305244054272;1997.980020199794;1999.0804230054193;20856.165753369845;21464;21474.57050858974;21476.57046859054;21504.677429838564;2501.6622755927897;2523.4574566468114;2619.4761047790516;2671.8664066796778;2685.261553072901;145740;149708;149953;151183;155641.99999999886;20357.796422035888;22099.342549308865;22310.776892231195;23138.421539461648;23564.175253866033;46954;46981.530184697716;47125;47141.292880606816;47231.763841180575;11516.712082198012;11702.053740706631;11824.881751182551;11851.46668399924;11922.582709605122;8449.112843151504;9745.366551174293;9777.706668799947;9828.950855245677;9950.10449059588;10168.4915754212;11692.603016381621;11758.412079396167;11874.465649045813;12124.757504849853;3715.331240376758;4092.3247664135083;4154.771487568213;4255.361695745601;4492.303692927601;960.1694534227983;982.886967998675;984.2913102566141;991.6380521109743;999.1008092716613;19960.70058949117;20090.497737556387;20373.898130509253;24007.879960600087;25594.872025640125;1059.6344261229863;1070.737669271018;1074.693712291993;1084.4794498640697;1102.581019212694;11220.326780393203;11558.884411155781;11571.884281157249;11613.36126513033;11703.590374336858;529790;543179;549138;566664;567647;112807;119192;121007;121588.39205803914;122388;1264.6269350541613;1282.6152154353656;1306.7843805772131;1309.2733532889147;1315.7105436803888;18499.260029598667;18818.717719234497;19002.1449034791;21226.25708100209;22683.20608778685;58801;59939;60235.39764602298;60911.39088609057;61417.69291153516;67605;68618;68649.65675171593;71089;71102.28897710957;14688.118712877262;15300.387984480496;15345.46290879814;15356.232188390759;15360.539183824503;24814.25557233286;24897.75102249027;24927.750722492543;24952.37619059538;24971.50056998886;16650.75023874667;16952;17273.740893886854;17353.566160845574;17506.212220450365;16931.238094286033;17364.739528906823;17394.652106958045;17936.91031544834;18352.632947340713;17514.73727894108;17683.38108166208;17741.201645926223;17753.822461775217;18029.459116226535;14856.702865942836;14890.404383824958;14921.776173357192;15014.47449339268;15035.248237587859;17000;17088.40190593323;17111.743323849903;17149.485515434557;17156.227969741143 05:49:32 INFO - PID 6456 | |3;mootools.html;1378.3383975691665;1437.884969202464;1440.7406666799973;1441.1713264872694;1444.1623858162263;14185.787213191797;14452;14739.189344586044;14750.483733069344;14761.48334808282;14911.776323355158;15260.542183734506;15266.618334541641;15269.465568705098;15288.464903728373;2737.6988531261545;2790.1629511146675;2792.9162125136277;2793.7345952134515;2794.2455537005;2661.9334516637045;2731.0441345529102;2767.1421859223606;2768.1418760184406;2777.597248398981;2683.436478339551;2687.4625074985083;2732.617433559293;2733.8496382698945;2735.0700761741004;2564.640950266955;2569.203546900467;2579.1875559198793;2582.845029298248;2588.184721812642;2609.556375416165;2622.278873309836;2635.222609330252;2657.162993657011;2663.5072511585226;14261.643458913506;14473.131612103307;14540.27298635064;14571.708565828623;14572.271386430635;7836.098848632423;8147.714829980922;8164.979377577803;8170.3872209584515;8175.182481751836;4900.436449808282;5030.798768049273;5083.440821509631;5137.434882162959;5152.149895267276;1715.408184176457;1733.9566510837203;1759.7888253409544;1772.5568607848038;1791.3998810398532;23437.296881093593;23747.88126059376;24385.146519871898;24905.750942490526;24912.875435622886;6665.500087493458;6671.199456065303;6794.3545363190415;6878.65606719672;6937.930620693829;16099.839001610067;16493.34026638921;16550.66898662044;16949.237284322237;17011.744823827652;7852.332551733167;8092.757217283491;8095.716649917343;8100.675972961133;8101.108878023413;7269.963650181715;7380.667869945865;7425.257474252531;7471.887921681179;7475.887861682079;5163.3545806774155;5300.946990530122;5313.8937221255355;5322.2548843161985;5331.120365139708;1255.5668294438403;1256.064232147038;1271.4215032160346;1278.0606254403006;1295.533607901155;893.2050475077186;905.7961958559272;913.8492148795374;921.9953900230456;924.1682485762733;7280.199178090405;7302.780916572511;7320.597367144858;7331.303526165006;7388.667509962064;698.3784431855653;706.2937062937064;713.2938390992983;724.1889084225701;736.1828370508731;4414.1171765647;4489.663275254369;4749.073930583503;5043.84868453947;5234.13636749932;19176.904115479614;19611.411657650293;19869.105890234972;20478.078486468145;20494.79505204929;19273.22907083701;19671.21315147378;19864;20210;20319.984000800196;10837.458127093614;11017;11207;11376.203665743484;11387.544498220144;7946.443748937519;7953;7970.880436793569;8014.398920080901;8067.757967260992;17278.91360543189;17303.221355039306;17376.91311543434;17448.302067917142;17470.563235918697;17518.124093795006;17542.210600523264;17708.380206692706;17922.5519362017;17954.5511362217;11787.292762434281;11827.881721182677;11956.880431195577;12015.579454719043;12017.579384721494;12439.502419903103;12529.122961392979;12552.246865188117;12557.372131393211;12564.874351256736;10980.341179529254;10986.176036797113;11028.28316159447;11134.164937629872;11277.887221128012;10837.566497340018;10883.945580272364;11051.778964420506;11206.327620342805;11239.100871930063;9189.816203676022;9365.812683746422;9369.156775890202;9373.531323433937;9376.296777741833;6924.930750692429;6982;7024.227334993249;7067.363937245467;7071.25751796054;6972.302769722987;7063.223045465097;7070.964645176741;7099.645017748989;7146.071010768567 05:49:32 INFO - PID 6456 | |4;prototype.html;495.9578435832955;499.12652857499353;528.888933324002;530.4324372920971;532.196383460974;6252.499800015999;6299.1496148020005;6304.558680892339;6336.637622911073;6339.397757213069;5961.731722072506;6082.361352058037;6119.2350956130485;6163.167972323735;6240.781572644958;4923.458419573862;4981.576565991895;4995.325631039817;5066.873328166797;5068.8732781680565;4987.8254261100865;4992.151334273182;4992.975035124838;5019.121653710605;5044.571211447013;4756.453007904101;4901.1177987962155;4942.406911170665;4960.801567937297;5012.9749351253195;4928.654994150411;4938.851834444972;4972.776225069881;5003.4246061702825;5031.119554078022;4485.34962430449;4488.326750987346;4516.728996260234;4533.478649955265;4537.682362234645;6073.939260607382;6074.149619053336;6146.600470969417;6183.598066125687;6194.81415557534;5751.942480575182;5758.683272420015;5790.309849022306;5816.912746308809;5829.417058294179;6585;6631.469482441441;6636.701348439284;6672.232693240291;6682.632455214961;4943.9258411123865;4950.925736113961;4959.504049595048;4967.3542439483;4983.127952608315;6927.965360173217;6999.89500157493;7032.367086962198;7051.224365319811;7104.786856394317;5016.724080175552;5061.5950723942;5073.746312684351;5082.567981721521;5103.693778373309;5132.12753831842;5144.717040562805;5145.974270128625;5190.506901844319;5208.7916483341;5777.94222057774;5790.42095790426;5811.157382179645;5832.825015249549;5860.619059761102;6611.900821487681;6641.501887358468;6687.866242675216;6705.195376554747;6760.932390676128;1680.7899012623423;1736.6439879824607;1765.7904335529947;1793.6861049316317;1798.2716999615177;1220.286132612414;1223.2843786385065;1230.5877531027206;1256.1834807375278;1257.415301884628;5684.232628595087;5745.2818397700285;5753.568482363839;5777.711114444261;5793.681347525842;6567.179102612174;6683.598984060972;6717.261101278856;6718.798436046926;6785.253622101565;5749.54003679713;5782.624129431658;5818.2436283282905;5823.505002074871;5825.097109947965;3600.6399360064306;3624.8006359649944;3638.6543278388513;3668.1563240454843;3670.2659468105953;6609.504287178481;6609.702563384659;6641.867162656817;6673.132492776005;6702.36327548882;6982.650867456607;6990.860182796418;6997.9650101750185;7012.964935175291;7061;6562.259512078165;6572.34276572339;6606.786726446502;6614.437772789271;6658.501837086616;6617.239017513048;6683.298253683293;6741.460683145435;6768.627725474949;6792.592444453348;6642.800715978528;6643.269240383457;6710.731570737116;6781.728730850711;6850.246472887879;6605.801825945229;6612.4710023198995;6649.2685804562425;6691;6715.3620406061345;4995.625328100335;5000.549950504472;5020.297158397901;5030.346055012971;5030.698158110525;6782.423494003065;6789.796306110825;6849.383555480031;6895.862082758417;6924.376806087476;6546.378094081055;6611.768588099393;6626.668666566556;6701.497387696039;6745.5952642841585;6315.431611155018;6499.967500162469;6542.44389226902;6626.337366263528;6631.767888123893;6168.19813424252;6319.24169099711;6407.391297826699;6468.223813142453;6523.445507131947;6510.828050950874;6539.280679125388;6540.967295163494;6592.934070659424;6688.130543029375;6344.270408903035;6355.269144048309;6379.712912918837;6455.386738259858;6514.609123452608 05:49:32 INFO - PID 6456 | |5;yui.html;922.3082687984012;930.3766476460771;937.4609599480297;943.2359788571262;954.7040417470582;19148.329808456707;19624.313149039786;19742.210311587554;19929.501762455944;20305.898470507665;21403;21743.13027478899;22091.447713807163;22187.66718499224;22259.332220033426;1018.9235807314426;1057.1595581512677;1059.3749687684265;1059.6873922192933;1064.9467526623637;1016.3241444439439;1060.2154405739775;1064.4252103863905;1064.9361038337686;1073.0932362153967;1101.1741194104422;1107.0313475708756;1107.2581370481757;1108.5953626926155;1110.8944650258213;1091.5524634899732;1101.031092638477;1103.7020004598794;1106.6679996001208;1108.7782443511248;802.5265093594749;807.1363640904235;808.623989844725;809.9716509922124;810.05628442864;19156.946367949757;19351.806481935142;19362.515937101543;19810.10854511536;20297.289594864258;21180.258690945742;21466.141354345807;21679.024443900063;21710.891445542828;22109.226177083725;16352.83647163525;16371.918140409342;16621.916890415592;16633.750493742602;16637.91681041587;3687.668109870098;3711.2763011212824;3718.6095459976855;3718.6095459976855;3720.6093360197333;126104;126827;128691;129975.35012324972;130626;16501.504954851374;16783.748243776354;16901.23944422504;16916.492505224618;17196;31151.844240779104;31653.8417307912;31718;32436.189095272806;32758.34483310368;7768.300852923264;8172.387070969582;8260.421770476129;8558.700445484377;8721.60752766127;4441.622462090694;4521.773911304487;4527.071950250191;4535.7732113394195;4541.250693635513;4964.60283177345;5052.621053421009;5060.2156665716875;5097.745112744422;5123.538881500683;959.5010594490826;984.1831280037552;995.1690338567232;996.3324572536418;996.6561536269975;667.0794303860738;682.5631595778706;697.3235961117708;703.2159142556013;709.7622296530617;11579.942100289445;11906.88093119075;12015.339156346485;12122.212056216318;12435.875641243472;648.0635481728857;654.4208375587544;654.9574277671936;676.4385559985201;692.1106378303855;5699.287589051369;5705.286839145107;5748.913766293509;5790.594658373873;5864.413558644102;118188.81811181777;120233;120545;123159;125912;99777;102417;102703;107172.4641376788;107756.46121769342;84735;88301;89029.55485222532;92195;92439.53780231056;10512.26414151002;10562.683119506428;10563.366198027836;10786.838197426889;10794.2983706062;40157.79921100376;41123.38314925339;41299.58700412957;41553.376699348926;41705.16589668129;71816.28183718096;73352.63323683347;77288.61355693186;77361.22638773765;81034;14898.180600066667;18224.271029158685;19166.8083319165;19181.904090479456;19573.314933977243;16783.74824377611;18206.36277730273;19296.517587060436;19631.509212269808;19842.20631174737;17005.82994170092;17037.57406064858;17145.82854171442;18105.909470452563;18236.817631824044;17759.733603995694;18360.357387491375;18361.908190458962;18405.53986150357;18506.81493185051;17342.132893355534;17628.647427051645;18679;18722.438326850217;18886.905565472083;12831.10182287231;13352.198868067948;13358.465661373824;13370.532031378854;13434.05961582719;13527.661808454868;13610.727785444433;13813.861861381258;14037.859621403655;14147.929260353632 05:49:32 INFO - PID 6456 | __end_tp_report 05:49:32 INFO - PID 6456 | __start_cc_report 05:49:32 INFO - PID 6456 | _x_x_mozilla_cycle_collect,375 05:49:32 INFO - PID 6456 | __end_cc_report 05:49:32 INFO - PID 6456 | __startTimestamp1503319772392__endTimestamp 05:49:32 INFO - PID 6456 | 05:49:32 INFO - PID 6456 | ------- Summary: start ------- 05:49:32 INFO - PID 6456 | Number of tests: 6 05:49:32 INFO - PID 6456 | 05:49:32 INFO - PID 6456 | [#0] dojo.html Cycles:165 Average:6189.29 Median:6480.09 stddev:736.42 (11.4%) stddev-sans-first:699.62 05:49:32 INFO - PID 6456 | Values: 3172.6 3173.5 3174.1 3182.7 3224.8 6162.3 6214.4 6248.3 6268.0 6304.1 6153.4 6236.3 6253.9 6257.6 6267.3 5674.7 5675.1 5771.9 5792.1 5803.7 5625.9 5741.2 5754.2 5781.4 5812.0 5533.2 5651.5 5655.7 5739.4 5745.9 5696.9 5709.1 5758.3 5762.3 5772.6 5543.8 5618.1 5674.8 5724.1 5729.3 6173.2 6224.5 6227.4 6246.0 6252.1 6671.4 6678.2 6753.9 6777.3 6785.9 6586.0 6746.4 6774.4 6859.3 6861.6 6201.1 6239.2 6245.9 6255.4 6272.1 6886.7 6958.1 6971.4 6974.1 7004.7 6450.9 6552.1 6578.5 6652.4 6667.1 6485.1 6578.8 6681.5 6756.4 6763.5 6716.1 6724.7 6730.9 6755.9 6761.9 6683.5 6687.1 6752.0 6753.5 6780.7 5423.3 5452.6 5519.1 5523.5 5523.6 4617.7 4621.6 4652.3 4654.1 4667.5 5762.3 5838.1 5842.2 5848.7 5856.2 6656.1 6763.4 6816.1 6843.3 6866.7 5664.5 5787.0 5865.6 5880.6 5896.1 5893.6 5917.9 5927.4 5987.5 5992.4 6365.0 6490.7 6585.3 6585.9 6592.4 6619.5 6710.8 6733.5 6766.1 6768.7 6480.1 6508.5 6513.5 6532.0 6532.4 6599.7 6607.9 6616.2 6623.1 6682.9 6790.8 6829.9 6833.2 6842.3 6848.3 6503.3 6539.6 6602.1 6606.8 6608.1 6402.9 6488.4 6502.3 6510.5 6588.3 6525.1 6551.4 6563.2 6568.2 6591.7 6597.1 6620.6 6699.8 6703.0 6712.6 6280.5 6384.6 6397.6 6400.1 6485.8 05:49:32 INFO - PID 6456 | 05:49:32 INFO - PID 6456 | [#1] ext.html Cycles:180 Average:38447.90 Median:19816.55 stddev:54745.41 (276.3%) stddev-sans-first:54825.99 05:49:32 INFO - PID 6456 | Values: 797.6 858.2 886.0 1185.2 1205.3 30895.0 43199.4 43772.6 43791.0 43808.8 43477.0 43900.8 43992.3 43992.3 44022.8 7637.3 7741.0 7776.8 7779.9 7782.9 7689.5 7786.3 7797.1 7798.3 7800.1 7243.6 7417.0 7811.7 7816.1 7816.5 7693.3 7756.1 7756.4 7757.4 7760.5 7642.7 7734.2 7739.7 7740.3 7743.2 39670.0 39799.0 39869.8 39894.2 39927.2 3578.3 3624.6 3625.2 3627.4 3637.8 32080.0 32173.2 32179.1 32242.5 32305.2 4893.5 5061.8 5116.3 5122.1 5210.2 198952.0 199600.0 200643.0 201456.0 201463.0 47394.3 47445.3 47457.8 47597.5 47631.6 50832.0 50844.2 50941.5 51006.5 51033.2 16273.6 16706.8 16718.4 16722.1 16776.7 13732.7 13765.5 13765.6 13791.7 13808.9 13041.1 14757.6 14858.6 14913.0 14944.3 5230.4 5917.1 5968.7 5987.4 6264.9 991.3 1007.9 1019.8 1033.1 1034.6 23098.5 23477.0 23646.0 23665.1 23824.0 1117.0 1117.2 1127.7 1134.0 1135.3 12492.4 12523.7 12547.9 12555.0 12642.6 233742.0 234523.0 236356.0 236741.0 236956.0 53404.5 53422.0 53580.7 53836.0 53891.5 1446.4 1459.7 1489.1 1498.6 1509.1 22641.0 22693.5 22895.7 23054.3 23227.0 37765.6 37889.4 37907.2 37924.6 37944.0 195378.0 195927.0 196096.0 196369.0 196416.0 35214.0 35269.6 35302.6 35545.6 35597.1 39260.8 39773.0 39860.4 42251.8 45014.1 25087.2 31295.0 32607.5 35576.8 35944.1 34870.0 35252.5 36008.5 36306.8 36356.3 39054.4 39063.4 39248.8 39335.4 39575.0 34615.1 35057.8 35126.5 35127.6 35185.0 23231.5 24184.4 24983.0 25119.4 25464.9 05:49:32 INFO - PID 6456 | 05:49:32 INFO - PID 6456 | [#2] jquery.html Cycles:180 Average:38418.32 Median:23756.85 stddev:92427.80 (389.1%) stddev-sans-first:92643.37 05:49:32 INFO - PID 6456 | Values: 554.9 566.4 571.7 572.4 582.1 22882.0 23745.6 23754.2 23759.5 23762.5 25223.0 27664.3 27674.9 27748.3 27867.6 6668.3 6804.9 6827.8 6834.2 6836.7 6612.8 6629.3 6672.5 6927.6 6957.3 6934.7 6944.4 6950.5 6955.4 6957.1 6934.4 6935.0 6937.5 6939.1 6939.6 6783.0 6786.8 6810.4 6819.8 6833.6 32177.5 32450.0 32846.7 33019.2 33174.2 1930.5 1978.6 1993.8 1998.0 1999.1 20856.2 21464.0 21474.6 21476.6 21504.7 2501.7 2523.5 2619.5 2671.9 2685.3 145740.0 149708.0 149953.0 151183.0 155642.0 20357.8 22099.3 22310.8 23138.4 23564.2 46954.0 46981.5 47125.0 47141.3 47231.8 11516.7 11702.1 11824.9 11851.5 11922.6 8449.1 9745.4 9777.7 9829.0 9950.1 10168.5 11692.6 11758.4 11874.5 12124.8 3715.3 4092.3 4154.8 4255.4 4492.3 960.2 982.9 984.3 991.6 999.1 19960.7 20090.5 20373.9 24007.9 25594.9 1059.6 1070.7 1074.7 1084.5 1102.6 11220.3 11558.9 11571.9 11613.4 11703.6 529790.0 543179.0 549138.0 566664.0 567647.0 112807.0 119192.0 121007.0 121588.4 122388.0 1264.6 1282.6 1306.8 1309.3 1315.7 18499.3 18818.7 19002.1 21226.3 22683.2 58801.0 59939.0 60235.4 60911.4 61417.7 67605.0 68618.0 68649.7 71089.0 71102.3 14688.1 15300.4 15345.5 15356.2 15360.5 24814.3 24897.8 24927.8 24952.4 24971.5 16650.8 16952.0 17273.7 17353.6 17506.2 16931.2 17364.7 17394.7 17936.9 18352.6 17514.7 17683.4 17741.2 17753.8 18029.5 14856.7 14890.4 14921.8 15014.5 15035.2 17000.0 17088.4 17111.7 17149.5 17156.2 05:49:32 INFO - PID 6456 | 05:49:32 INFO - PID 6456 | [#3] mootools.html Cycles:180 Average:8931.70 Median:2615.92 stddev:6210.30 (237.4%) stddev-sans-first:6201.79 05:49:32 INFO - PID 6456 | Values: 1378.3 1437.9 1440.7 1441.2 1444.2 14185.8 14452.0 14739.2 14750.5 14761.5 14911.8 15260.5 15266.6 15269.5 15288.5 2737.7 2790.2 2792.9 2793.7 2794.2 2661.9 2731.0 2767.1 2768.1 2777.6 2683.4 2687.5 2732.6 2733.8 2735.1 2564.6 2569.2 2579.2 2582.8 2588.2 2609.6 2622.3 2635.2 2657.2 2663.5 14261.6 14473.1 14540.3 14571.7 14572.3 7836.1 8147.7 8165.0 8170.4 8175.2 4900.4 5030.8 5083.4 5137.4 5152.1 1715.4 1734.0 1759.8 1772.6 1791.4 23437.3 23747.9 24385.1 24905.8 24912.9 6665.5 6671.2 6794.4 6878.7 6937.9 16099.8 16493.3 16550.7 16949.2 17011.7 7852.3 8092.8 8095.7 8100.7 8101.1 7270.0 7380.7 7425.3 7471.9 7475.9 5163.4 5300.9 5313.9 5322.3 5331.1 1255.6 1256.1 1271.4 1278.1 1295.5 893.2 905.8 913.8 922.0 924.2 7280.2 7302.8 7320.6 7331.3 7388.7 698.4 706.3 713.3 724.2 736.2 4414.1 4489.7 4749.1 5043.8 5234.1 19176.9 19611.4 19869.1 20478.1 20494.8 19273.2 19671.2 19864.0 20210.0 20320.0 10837.5 11017.0 11207.0 11376.2 11387.5 7946.4 7953.0 7970.9 8014.4 8067.8 17278.9 17303.2 17376.9 17448.3 17470.6 17518.1 17542.2 17708.4 17922.6 17954.6 11787.3 11827.9 11956.9 12015.6 12017.6 12439.5 12529.1 12552.2 12557.4 12564.9 10980.3 10986.2 11028.3 11134.2 11277.9 10837.6 10883.9 11051.8 11206.3 11239.1 9189.8 9365.8 9369.2 9373.5 9376.3 6924.9 6982.0 7024.2 7067.4 7071.3 6972.3 7063.2 7071.0 7099.6 7146.1 05:49:32 INFO - PID 6456 | 05:49:32 INFO - PID 6456 | [#4] prototype.html Cycles:180 Average:5562.93 Median:6154.88 stddev:1564.49 (25.4%) stddev-sans-first:1521.95 05:49:32 INFO - PID 6456 | Values: 496.0 499.1 528.9 530.4 532.2 6252.5 6299.1 6304.6 6336.6 6339.4 5961.7 6082.4 6119.2 6163.2 6240.8 4923.5 4981.6 4995.3 5066.9 5068.9 4987.8 4992.2 4993.0 5019.1 5044.6 4756.5 4901.1 4942.4 4960.8 5013.0 4928.7 4938.9 4972.8 5003.4 5031.1 4485.3 4488.3 4516.7 4533.5 4537.7 6073.9 6074.1 6146.6 6183.6 6194.8 5751.9 5758.7 5790.3 5816.9 5829.4 6585.0 6631.5 6636.7 6672.2 6682.6 4943.9 4950.9 4959.5 4967.4 4983.1 6928.0 6999.9 7032.4 7051.2 7104.8 5016.7 5061.6 5073.7 5082.6 5103.7 5132.1 5144.7 5146.0 5190.5 5208.8 5777.9 5790.4 5811.2 5832.8 5860.6 6611.9 6641.5 6687.9 6705.2 6760.9 1680.8 1736.6 1765.8 1793.7 1798.3 1220.3 1223.3 1230.6 1256.2 1257.4 5684.2 5745.3 5753.6 5777.7 5793.7 6567.2 6683.6 6717.3 6718.8 6785.3 5749.5 5782.6 5818.2 5823.5 5825.1 3600.6 3624.8 3638.7 3668.2 3670.3 6609.5 6609.7 6641.9 6673.1 6702.4 6982.7 6990.9 6998.0 7013.0 7061.0 6562.3 6572.3 6606.8 6614.4 6658.5 6617.2 6683.3 6741.5 6768.6 6792.6 6642.8 6643.3 6710.7 6781.7 6850.2 6605.8 6612.5 6649.3 6691.0 6715.4 4995.6 5000.5 5020.3 5030.3 5030.7 6782.4 6789.8 6849.4 6895.9 6924.4 6546.4 6611.8 6626.7 6701.5 6745.6 6315.4 6500.0 6542.4 6626.3 6631.8 6168.2 6319.2 6407.4 6468.2 6523.4 6510.8 6539.3 6541.0 6592.9 6688.1 6344.3 6355.3 6379.7 6455.4 6514.6 05:49:32 INFO - PID 6456 | 05:49:32 INFO - PID 6456 | [#5] yui.html Cycles:180 Average:24595.39 Median:19598.81 stddev:34085.42 (173.9%) stddev-sans-first:34134.69 05:49:32 INFO - PID 6456 | Values: 922.3 930.4 937.5 943.2 954.7 19148.3 19624.3 19742.2 19929.5 20305.9 21403.0 21743.1 22091.4 22187.7 22259.3 1018.9 1057.2 1059.4 1059.7 1064.9 1016.3 1060.2 1064.4 1064.9 1073.1 1101.2 1107.0 1107.3 1108.6 1110.9 1091.6 1101.0 1103.7 1106.7 1108.8 802.5 807.1 808.6 810.0 810.1 19156.9 19351.8 19362.5 19810.1 20297.3 21180.3 21466.1 21679.0 21710.9 22109.2 16352.8 16371.9 16621.9 16633.8 16637.9 3687.7 3711.3 3718.6 3718.6 3720.6 126104.0 126827.0 128691.0 129975.4 130626.0 16501.5 16783.7 16901.2 16916.5 17196.0 31151.8 31653.8 31718.0 32436.2 32758.3 7768.3 8172.4 8260.4 8558.7 8721.6 4441.6 4521.8 4527.1 4535.8 4541.3 4964.6 5052.6 5060.2 5097.7 5123.5 959.5 984.2 995.2 996.3 996.7 667.1 682.6 697.3 703.2 709.8 11579.9 11906.9 12015.3 12122.2 12435.9 648.1 654.4 655.0 676.4 692.1 5699.3 5705.3 5748.9 5790.6 5864.4 118188.8 120233.0 120545.0 123159.0 125912.0 99777.0 102417.0 102703.0 107172.5 107756.5 84735.0 88301.0 89029.6 92195.0 92439.5 10512.3 10562.7 10563.4 10786.8 10794.3 40157.8 41123.4 41299.6 41553.4 41705.2 71816.3 73352.6 77288.6 77361.2 81034.0 14898.2 18224.3 19166.8 19181.9 19573.3 16783.7 18206.4 19296.5 19631.5 19842.2 17005.8 17037.6 17145.8 18105.9 18236.8 17759.7 18360.4 18361.9 18405.5 18506.8 17342.1 17628.6 18679.0 18722.4 18886.9 12831.1 13352.2 13358.5 13370.5 13434.1 13527.7 13610.7 13813.9 14037.9 14147.9 05:49:32 INFO - PID 6456 | -------- Summary: end -------- 05:49:32 INFO - PID 6456 | 05:49:33 INFO - TEST-INFO | 6456: exit 0 05:49:33 INFO - TEST-OK | dromaeo_css | took 1111382ms 05:49:33 INFO - TEST-START | kraken 05:49:33 INFO - Initialising browser for kraken test... 05:49:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60128/getInfo.html -profile /tmp/tmpbCnVvg/profile 05:49:33 INFO - TEST-INFO | started process 6873 (/builds/slave/test/build/application/firefox/firefox http://localhost:60128/getInfo.html) 05:49:38 INFO - TEST-INFO | 6873: exit 0 05:49:39 INFO - Browser initialized. 05:49:39 INFO - Running cycle 1/1 for kraken test... 05:49:39 INFO - TEST-INFO | started process 7046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbCnVvg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:40 INFO - PID 7046 | 05:49:40 INFO - PID 7046 | (/builds/slave/test/build/application/firefox/firefox:7095): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:49:40 INFO - PID 7046 | 05:49:40 INFO - PID 7046 | 05:49:40 INFO - PID 7046 | (/builds/slave/test/build/application/firefox/firefox:7150): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:49:40 INFO - PID 7046 | 05:49:40 INFO - PID 7046 | __metrics Screen width/height:1600/1200 05:49:40 INFO - PID 7046 | colorDepth:24 05:49:40 INFO - PID 7046 | Browser inner width/height: 1024/768 05:49:40 INFO - PID 7046 | __metrics 05:49:50 INFO - PID 7046 | RSS: Main: 171700224 05:49:50 INFO - PID 7046 | 05:49:52 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60128/tests/kraken/driver.html?testName=audio-beat-detection) 05:49:53 INFO - PID 7046 | RSS: Main: 174886912 05:49:53 INFO - PID 7046 | 05:49:56 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60128/tests/kraken/driver.html?testName=audio-dft) 05:49:57 INFO - PID 7046 | RSS: Main: 177541120 05:49:57 INFO - PID 7046 | 05:50:00 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60128/tests/kraken/driver.html?testName=audio-fft) 05:50:00 INFO - PID 7046 | RSS: Main: 170991616 05:50:00 INFO - PID 7046 | 05:50:02 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60128/tests/kraken/driver.html?testName=audio-oscillator) 05:50:03 INFO - PID 7046 | RSS: Main: 172769280 05:50:03 INFO - PID 7046 | 05:50:05 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60128/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:50:06 INFO - PID 7046 | RSS: Main: 172613632 05:50:06 INFO - PID 7046 | 05:50:09 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60128/tests/kraken/driver.html?testName=imaging-darkroom) 05:50:09 INFO - PID 7046 | RSS: Main: 173400064 05:50:09 INFO - PID 7046 | 05:50:13 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60128/tests/kraken/driver.html?testName=imaging-desaturate) 05:50:14 INFO - PID 7046 | RSS: Main: 174178304 05:50:14 INFO - PID 7046 | 05:50:16 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60128/tests/kraken/driver.html?testName=json-parse-financial) 05:50:17 INFO - PID 7046 | RSS: Main: 174534656 05:50:17 INFO - PID 7046 | 05:50:19 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60128/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:50:19 INFO - PID 7046 | RSS: Main: 173543424 05:50:19 INFO - PID 7046 | 05:50:21 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60128/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:50:22 INFO - PID 7046 | RSS: Main: 174452736 05:50:22 INFO - PID 7046 | 05:50:24 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60128/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:50:24 INFO - PID 7046 | RSS: Main: 174063616 05:50:24 INFO - PID 7046 | 05:50:27 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60128/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:50:28 INFO - PID 7046 | RSS: Main: 173944832 05:50:28 INFO - PID 7046 | 05:50:31 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60128/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:50:31 INFO - PID 7046 | RSS: Main: 173801472 05:50:31 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | Cycle 1(1): loaded http://localhost:60128/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60128/tests/kraken/driver.html?testName=ai-astar) 05:50:33 INFO - PID 7046 | RSS: Main: 175661056 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | __start_tp_report 05:50:33 INFO - PID 7046 | _x_x_mozilla_page_load 05:50:33 INFO - PID 7046 | _x_x_mozilla_page_load_details 05:50:33 INFO - PID 7046 | |i|pagename|runs| 05:50:33 INFO - PID 7046 | |0;ai-astar;97;108;101;107;108;110;114;100;107;110 05:50:33 INFO - PID 7046 | |1;audio-beat-detection;143;116;147;180;124;148;143;124;169;120 05:50:33 INFO - PID 7046 | |2;audio-dft;162;162;162;161;162;165;164;164;167;166 05:50:33 INFO - PID 7046 | |3;audio-fft;75;75;83;164;75;75;74;86;102;76 05:50:33 INFO - PID 7046 | |4;audio-oscillator;79;78;133;80;78;84;123;79;78;125 05:50:33 INFO - PID 7046 | |5;imaging-gaussian-blur;114;115;114;114;114;114;114;114;113;113 05:50:33 INFO - PID 7046 | |6;imaging-darkroom;160;150;151;151;153;149;150;148;150;151 05:50:33 INFO - PID 7046 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;93 05:50:33 INFO - PID 7046 | |8;json-parse-financial;56;56;57;55;55;57;56;55;55;55 05:50:33 INFO - PID 7046 | |9;json-stringify-tinderbox;54;54;54;56;54;54;59;55;54;54 05:50:33 INFO - PID 7046 | |10;stanford-crypto-aes;76;86;76;74;75;74;74;79;75;84 05:50:33 INFO - PID 7046 | |11;stanford-crypto-ccm;122;128;129;124;123;129;119;121;137;155 05:50:33 INFO - PID 7046 | |12;stanford-crypto-pbkdf2;173;172;168;180;176;175;173;173;181;170 05:50:33 INFO - PID 7046 | |13;stanford-crypto-sha256-iterative;79;68;69;67;71;67;65;65;65;65 05:50:33 INFO - PID 7046 | __end_tp_report 05:50:33 INFO - PID 7046 | __start_cc_report 05:50:33 INFO - PID 7046 | _x_x_mozilla_cycle_collect,935 05:50:33 INFO - PID 7046 | __end_cc_report 05:50:33 INFO - PID 7046 | __startTimestamp1503319833812__endTimestamp 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | ------- Summary: start ------- 05:50:33 INFO - PID 7046 | Number of tests: 14 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#0] ai-astar Cycles:10 Average:106.20 Median:109.00 stddev:5.25 (4.8%) stddev-sans-first:4.38 05:50:33 INFO - PID 7046 | Values: 97.0 108.0 101.0 107.0 108.0 110.0 114.0 100.0 107.0 110.0 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:145.00 stddev:21.19 (14.6%) stddev-sans-first:22.47 05:50:33 INFO - PID 7046 | Values: 143.0 116.0 147.0 180.0 124.0 148.0 143.0 124.0 169.0 120.0 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:2.01 (1.2%) stddev-sans-first:2.06 05:50:33 INFO - PID 7046 | Values: 162.0 162.0 162.0 161.0 162.0 165.0 164.0 164.0 167.0 166.0 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#3] audio-fft Cycles:10 Average:88.50 Median:75.00 stddev:27.92 (37.2%) stddev-sans-first:29.18 05:50:33 INFO - PID 7046 | Values: 75.0 75.0 83.0 164.0 75.0 75.0 74.0 86.0 102.0 76.0 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:78.50 stddev:23.18 (29.5%) stddev-sans-first:23.97 05:50:33 INFO - PID 7046 | Values: 79.0 78.0 133.0 80.0 78.0 84.0 123.0 79.0 78.0 125.0 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:50:33 INFO - PID 7046 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 113.0 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.00 stddev:3.33 (2.2%) stddev-sans-first:1.41 05:50:33 INFO - PID 7046 | Values: 160.0 150.0 151.0 151.0 153.0 149.0 150.0 148.0 150.0 151.0 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:50:33 INFO - PID 7046 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 05:50:33 INFO - PID 7046 | Values: 56.0 56.0 57.0 55.0 55.0 57.0 56.0 55.0 55.0 55.0 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:54.00 stddev:1.62 (3.0%) stddev-sans-first:1.69 05:50:33 INFO - PID 7046 | Values: 54.0 54.0 54.0 56.0 54.0 54.0 59.0 55.0 54.0 54.0 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:76.00 stddev:4.35 (5.7%) stddev-sans-first:4.59 05:50:33 INFO - PID 7046 | Values: 76.0 86.0 76.0 74.0 75.0 74.0 74.0 79.0 75.0 84.0 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:128.50 stddev:10.61 (8.3%) stddev-sans-first:10.98 05:50:33 INFO - PID 7046 | Values: 122.0 128.0 129.0 124.0 123.0 129.0 119.0 121.0 137.0 155.0 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:174.00 stddev:4.07 (2.3%) stddev-sans-first:4.29 05:50:33 INFO - PID 7046 | Values: 173.0 172.0 168.0 180.0 176.0 175.0 173.0 173.0 181.0 170.0 05:50:33 INFO - PID 7046 | 05:50:33 INFO - PID 7046 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:67.50 stddev:4.33 (6.4%) stddev-sans-first:2.15 05:50:33 INFO - PID 7046 | Values: 79.0 68.0 69.0 67.0 71.0 67.0 65.0 65.0 65.0 65.0 05:50:33 INFO - PID 7046 | -------- Summary: end -------- 05:50:33 INFO - PID 7046 | 05:50:34 INFO - PID 7046 | 05:50:34 INFO - PID 7046 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 05:50:34 INFO - PID 7046 | 05:50:34 INFO - PID 7046 | 05:50:34 INFO - PID 7046 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 05:50:34 INFO - PID 7046 | 05:50:34 INFO - PID 7046 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:50:34 INFO - TEST-INFO | 7046: exit 0 05:50:34 INFO - TEST-OK | kraken | took 61441ms 05:50:34 INFO - SUITE-END | took 1172s 05:50:34 INFO - Completed test suite (00:19:33) 05:50:34 INFO - javascript benchmark 05:50:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8682.088512576773, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3172.5717028201184, 3173.5398367236735, 3174.1112488503218, 3182.6817318268168, 3224.822634755089, 6162.291336496304, 6214.409631085051, 6248.250209974809, 6268.0, 6304.117423560694, 6153.35389784073, 6236.251649802019, 6253.906191407133, 6257.5619706620555, 6267.341929097447, 5674.687892165929, 5675.091985282366, 5771.913421298684, 5792.131180322943, 5803.709814509279, 5625.943740562603, 5741.167530708045, 5754.223179870727, 5781.364049954502, 5812.0410132328325, 5533.170024496338, 5651.519620832193, 5655.745491452874, 5739.426057394227, 5745.913811292834, 5696.943030569682, 5709.115087161496, 5758.280214973129, 5762.279715035621, 5772.595918285721, 5543.750531226105, 5618.073017952033, 5674.829755107354, 5724.141378793172, 5729.255196824428, 6173.228346456693, 6224.533160012972, 6227.439530442237, 6246.0, 6252.124702541648, 6671.432928201109, 6678.1986161660425, 6753.898691519631, 6777.288384719632, 6785.864282714368, 6586.0, 6746.359095885883, 6774.424173945221, 6859.31406859315, 6861.622610756406, 6201.100840378165, 6239.157713708682, 6245.937540624626, 6255.4057364549835, 6272.090546870678, 6886.690098945459, 6958.095447591882, 6971.407430368374, 6974.093367862146, 7004.719811207597, 6450.903236451457, 6552.115464412243, 6578.473722102221, 6652.401283884474, 6667.133272674619, 6485.092087107809, 6578.769743059066, 6681.498887583451, 6756.391924726799, 6763.492738044666, 6716.059751634775, 6724.697388617426, 6730.9326906731285, 6755.932440675629, 6761.898571521431, 6683.465322774166, 6687.130673012477, 6752.020956961312, 6753.49348798842, 6780.694868730919, 5423.3491980962535, 5452.59105567084, 5519.061759500894, 5523.530499907552, 5523.558115350843, 4617.676762626584, 4621.60716339115, 4652.302154676758, 4654.138984287918, 4667.509911459316, 5762.30852297727, 5838.065909454467, 5842.211301474246, 5848.678322692293, 5856.150858125633, 6656.101426307387, 6763.357481039294, 6816.113905192393, 6843.349881761224, 6866.725330986805, 5664.51851592611, 5787.0, 5865.560082993792, 5880.617759845596, 5896.056630939029, 5893.5579831512805, 5917.911231331534, 5927.436893495111, 5987.491063259585, 5992.370801065913, 6365.0, 6490.675466226669, 6585.308542603054, 6585.934140658628, 6592.439642630334, 6619.536632435876, 6710.798676039727, 6733.46132309414, 6766.086578311865, 6768.7292508299115, 6480.092787009728, 6508.544401892012, 6513.478921686348, 6532.0, 6532.379423954717, 6599.7360105595235, 6607.867842643024, 6616.2060552732055, 6623.105880706235, 6682.933170668425, 6790.830229244309, 6829.863402732017, 6833.214180369321, 6842.315768423317, 6848.3494068063455, 6503.25212600557, 6539.6403197824575, 6602.141721576164, 6606.8017959461295, 6608.140941677551, 6402.935970640234, 6488.448481879093, 6502.317256687979, 6510.5117116217425, 6588.308227636221, 6525.0538671893255, 6551.377619126175, 6563.212414510289, 6568.1789776277965, 6591.703373348307, 6597.109390232257, 6620.635865027277, 6699.8325041872395, 6703.0, 6712.597244165366, 6280.466160376236, 6384.553081284265, 6397.616143031433, 6400.103985442135, 6485.77299794505], "value": 6133.873542649657, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.6211299632672, 858.2104463893218, 886.0253720907003, 1185.1703807334861, 1205.3129716061849, 30895.0, 43199.35200971988, 43772.56227437725, 43791.0, 43808.78095609517, 43477.0, 43900.780496097475, 43992.3401148983, 43992.3401148983, 44022.77988610052, 7637.274458926393, 7740.961295193544, 7776.80557986052, 7779.8833017504785, 7782.883256751125, 7689.538627682329, 7786.3381612563, 7797.103333116707, 7798.2981531662135, 7800.141984381742, 7243.601601911892, 7416.962915185417, 7811.687532498721, 7816.140224575321, 7816.53100813953, 7693.346065584432, 7756.069271687434, 7756.418268629847, 7757.379409647215, 7760.534367937914, 7642.694292228304, 7734.226577342277, 7739.651715672809, 7740.303372696484, 7743.225677432268, 39670.0, 39799.0, 39869.80065099685, 39894.20211595781, 39927.20145597101, 3578.2664553766417, 3624.6375362463805, 3625.23869987303, 3627.4196128619296, 3637.763545369569, 32080.0, 32173.195670108435, 32179.06925584449, 32242.516362254584, 32305.1923701907, 4893.535114164149, 5061.822836200715, 5116.258142569344, 5122.052420302219, 5210.166373380241, 198952.0, 199600.0, 200643.0, 201456.0, 201463.0, 47394.289085663746, 47445.288320675216, 47457.762711186224, 47597.52402476, 47631.57105286847, 50832.0, 50844.23733643998, 50941.49058509368, 51006.489935100915, 51033.234501482504, 16273.593160170854, 16706.83293167077, 16718.41485548, 16722.080285584165, 16776.66446671084, 13732.725345493034, 13765.518206862711, 13765.587032389045, 13791.655208619664, 13808.861911380958, 13041.087123901425, 14757.631059223606, 14858.554243372717, 14913.030653007736, 14944.327505262288, 5230.37235531731, 5917.142014407973, 5968.671723055187, 5987.43119403656, 6264.937350626436, 991.2664628175098, 1007.9092881640687, 1019.7628852119456, 1033.0857191385528, 1034.6275340877278, 23098.53802923932, 23477.0, 23646.0, 23665.053397863892, 23824.0, 1117.044926587772, 1117.1788735279563, 1127.7124333295121, 1134.0020781712205, 1135.3074624479061, 12492.437840297209, 12523.686907827196, 12547.93726031364, 12555.0, 12642.55751048709, 233742.0, 234523.0, 236356.0, 236741.0, 236956.0, 53404.465955340725, 53422.0, 53580.73209634005, 53836.0, 53891.46108538943, 1446.3708286895235, 1459.7080583883267, 1489.0544504239886, 1498.6178524476188, 1509.056839475328, 22641.0, 22693.546129077655, 22895.656565151203, 23054.308370748906, 23227.0, 37765.62234377731, 37889.43165852459, 37907.241855163295, 37924.62075379211, 37944.0, 195378.0, 195927.0, 196096.0, 196369.0, 196416.0, 35214.0, 35269.64730352664, 35302.64697352993, 35545.64454355527, 35597.110072248404, 39260.80369598134, 39773.0, 39860.40209396919, 42251.7887410561, 45014.0997180048, 25087.247382578553, 31295.0, 32607.510887337183, 35576.822115889256, 35944.10139746423, 34870.0, 35252.47121293131, 36008.4598731014, 36306.818465907505, 36356.27287454289, 39054.4141837867, 39063.41404878986, 39248.80375598104, 39335.40996885106, 39575.0, 34615.13462163466, 35057.82471087628, 35126.473102902964, 35127.64872351346, 35185.0, 23231.53536929286, 24184.395390115387, 24983.0, 25119.372015699755, 25464.872675636503], "value": 17583.929706503106, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.8668319603294, 566.365670449097, 571.6827160925687, 572.4075581772865, 582.1297160744687, 22882.0, 23745.643815342784, 23754.16860409886, 23759.524809503822, 23762.524749505, 25223.0, 27664.308392290204, 27674.861625691843, 27748.306292342702, 27867.581986270223, 6668.266490686021, 6804.931950680504, 6827.829304267383, 6834.21406538247, 6836.726530938757, 6612.801615951529, 6629.303923088079, 6672.499562532806, 6927.618980956046, 6957.269486703899, 6934.687939042755, 6944.375006249436, 6950.478714096438, 6955.443564514852, 6957.095577574908, 6934.410575101122, 6935.029095926574, 6937.549059311179, 6939.0979172707475, 6939.618320992344, 6782.966085169592, 6786.830329241809, 6810.387065164109, 6819.795406137824, 6833.58998460089, 32177.51733723996, 32450.02649920506, 32846.67153328484, 33019.17452063718, 33174.17064573381, 1930.5173706573357, 1978.64384410806, 1993.8305244054272, 1997.980020199794, 1999.0804230054193, 20856.165753369845, 21464.0, 21474.57050858974, 21476.57046859054, 21504.677429838564, 2501.6622755927897, 2523.4574566468114, 2619.4761047790516, 2671.8664066796778, 2685.261553072901, 145740.0, 149708.0, 149953.0, 151183.0, 155641.99999999886, 20357.796422035888, 22099.342549308865, 22310.776892231195, 23138.421539461648, 23564.175253866033, 46954.0, 46981.530184697716, 47125.0, 47141.292880606816, 47231.763841180575, 11516.712082198012, 11702.053740706631, 11824.881751182551, 11851.46668399924, 11922.582709605122, 8449.112843151504, 9745.366551174293, 9777.706668799947, 9828.950855245677, 9950.10449059588, 10168.4915754212, 11692.603016381621, 11758.412079396167, 11874.465649045813, 12124.757504849853, 3715.331240376758, 4092.3247664135083, 4154.771487568213, 4255.361695745601, 4492.303692927601, 960.1694534227983, 982.886967998675, 984.2913102566141, 991.6380521109743, 999.1008092716613, 19960.70058949117, 20090.497737556387, 20373.898130509253, 24007.879960600087, 25594.872025640125, 1059.6344261229863, 1070.737669271018, 1074.693712291993, 1084.4794498640697, 1102.581019212694, 11220.326780393203, 11558.884411155781, 11571.884281157249, 11613.36126513033, 11703.590374336858, 529790.0, 543179.0, 549138.0, 566664.0, 567647.0, 112807.0, 119192.0, 121007.0, 121588.39205803914, 122388.0, 1264.6269350541613, 1282.6152154353656, 1306.7843805772131, 1309.2733532889147, 1315.7105436803888, 18499.260029598667, 18818.717719234497, 19002.1449034791, 21226.25708100209, 22683.20608778685, 58801.0, 59939.0, 60235.39764602298, 60911.39088609057, 61417.69291153516, 67605.0, 68618.0, 68649.65675171593, 71089.0, 71102.28897710957, 14688.118712877262, 15300.387984480496, 15345.46290879814, 15356.232188390759, 15360.539183824503, 24814.25557233286, 24897.75102249027, 24927.750722492543, 24952.37619059538, 24971.50056998886, 16650.75023874667, 16952.0, 17273.740893886854, 17353.566160845574, 17506.212220450365, 16931.238094286033, 17364.739528906823, 17394.652106958045, 17936.91031544834, 18352.632947340713, 17514.73727894108, 17683.38108166208, 17741.201645926223, 17753.822461775217, 18029.459116226535, 14856.702865942836, 14890.404383824958, 14921.776173357192, 15014.47449339268, 15035.248237587859, 17000.0, 17088.40190593323, 17111.743323849903, 17149.485515434557, 17156.227969741143], "value": 13104.030986206548, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.3383975691665, 1437.884969202464, 1440.7406666799973, 1441.1713264872694, 1444.1623858162263, 14185.787213191797, 14452.0, 14739.189344586044, 14750.483733069344, 14761.48334808282, 14911.776323355158, 15260.542183734506, 15266.618334541641, 15269.465568705098, 15288.464903728373, 2737.6988531261545, 2790.1629511146675, 2792.9162125136277, 2793.7345952134515, 2794.2455537005, 2661.9334516637045, 2731.0441345529102, 2767.1421859223606, 2768.1418760184406, 2777.597248398981, 2683.436478339551, 2687.4625074985083, 2732.617433559293, 2733.8496382698945, 2735.0700761741004, 2564.640950266955, 2569.203546900467, 2579.1875559198793, 2582.845029298248, 2588.184721812642, 2609.556375416165, 2622.278873309836, 2635.222609330252, 2657.162993657011, 2663.5072511585226, 14261.643458913506, 14473.131612103307, 14540.27298635064, 14571.708565828623, 14572.271386430635, 7836.098848632423, 8147.714829980922, 8164.979377577803, 8170.3872209584515, 8175.182481751836, 4900.436449808282, 5030.798768049273, 5083.440821509631, 5137.434882162959, 5152.149895267276, 1715.408184176457, 1733.9566510837203, 1759.7888253409544, 1772.5568607848038, 1791.3998810398532, 23437.296881093593, 23747.88126059376, 24385.146519871898, 24905.750942490526, 24912.875435622886, 6665.500087493458, 6671.199456065303, 6794.3545363190415, 6878.65606719672, 6937.930620693829, 16099.839001610067, 16493.34026638921, 16550.66898662044, 16949.237284322237, 17011.744823827652, 7852.332551733167, 8092.757217283491, 8095.716649917343, 8100.675972961133, 8101.108878023413, 7269.963650181715, 7380.667869945865, 7425.257474252531, 7471.887921681179, 7475.887861682079, 5163.3545806774155, 5300.946990530122, 5313.8937221255355, 5322.2548843161985, 5331.120365139708, 1255.5668294438403, 1256.064232147038, 1271.4215032160346, 1278.0606254403006, 1295.533607901155, 893.2050475077186, 905.7961958559272, 913.8492148795374, 921.9953900230456, 924.1682485762733, 7280.199178090405, 7302.780916572511, 7320.597367144858, 7331.303526165006, 7388.667509962064, 698.3784431855653, 706.2937062937064, 713.2938390992983, 724.1889084225701, 736.1828370508731, 4414.1171765647, 4489.663275254369, 4749.073930583503, 5043.84868453947, 5234.13636749932, 19176.904115479614, 19611.411657650293, 19869.105890234972, 20478.078486468145, 20494.79505204929, 19273.22907083701, 19671.21315147378, 19864.0, 20210.0, 20319.984000800196, 10837.458127093614, 11017.0, 11207.0, 11376.203665743484, 11387.544498220144, 7946.443748937519, 7953.0, 7970.880436793569, 8014.398920080901, 8067.757967260992, 17278.91360543189, 17303.221355039306, 17376.91311543434, 17448.302067917142, 17470.563235918697, 17518.124093795006, 17542.210600523264, 17708.380206692706, 17922.5519362017, 17954.5511362217, 11787.292762434281, 11827.881721182677, 11956.880431195577, 12015.579454719043, 12017.579384721494, 12439.502419903103, 12529.122961392979, 12552.246865188117, 12557.372131393211, 12564.874351256736, 10980.341179529254, 10986.176036797113, 11028.28316159447, 11134.164937629872, 11277.887221128012, 10837.566497340018, 10883.945580272364, 11051.778964420506, 11206.327620342805, 11239.100871930063, 9189.816203676022, 9365.812683746422, 9369.156775890202, 9373.531323433937, 9376.296777741833, 6924.930750692429, 6982.0, 7024.227334993249, 7067.363937245467, 7071.25751796054, 6972.302769722987, 7063.223045465097, 7070.964645176741, 7099.645017748989, 7146.071010768567], "value": 6403.760538187072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.9578435832955, 499.12652857499353, 528.888933324002, 530.4324372920971, 532.196383460974, 6252.499800015999, 6299.1496148020005, 6304.558680892339, 6336.637622911073, 6339.397757213069, 5961.731722072506, 6082.361352058037, 6119.2350956130485, 6163.167972323735, 6240.781572644958, 4923.458419573862, 4981.576565991895, 4995.325631039817, 5066.873328166797, 5068.8732781680565, 4987.8254261100865, 4992.151334273182, 4992.975035124838, 5019.121653710605, 5044.571211447013, 4756.453007904101, 4901.1177987962155, 4942.406911170665, 4960.801567937297, 5012.9749351253195, 4928.654994150411, 4938.851834444972, 4972.776225069881, 5003.4246061702825, 5031.119554078022, 4485.34962430449, 4488.326750987346, 4516.728996260234, 4533.478649955265, 4537.682362234645, 6073.939260607382, 6074.149619053336, 6146.600470969417, 6183.598066125687, 6194.81415557534, 5751.942480575182, 5758.683272420015, 5790.309849022306, 5816.912746308809, 5829.417058294179, 6585.0, 6631.469482441441, 6636.701348439284, 6672.232693240291, 6682.632455214961, 4943.9258411123865, 4950.925736113961, 4959.504049595048, 4967.3542439483, 4983.127952608315, 6927.965360173217, 6999.89500157493, 7032.367086962198, 7051.224365319811, 7104.786856394317, 5016.724080175552, 5061.5950723942, 5073.746312684351, 5082.567981721521, 5103.693778373309, 5132.12753831842, 5144.717040562805, 5145.974270128625, 5190.506901844319, 5208.7916483341, 5777.94222057774, 5790.42095790426, 5811.157382179645, 5832.825015249549, 5860.619059761102, 6611.900821487681, 6641.501887358468, 6687.866242675216, 6705.195376554747, 6760.932390676128, 1680.7899012623423, 1736.6439879824607, 1765.7904335529947, 1793.6861049316317, 1798.2716999615177, 1220.286132612414, 1223.2843786385065, 1230.5877531027206, 1256.1834807375278, 1257.415301884628, 5684.232628595087, 5745.2818397700285, 5753.568482363839, 5777.711114444261, 5793.681347525842, 6567.179102612174, 6683.598984060972, 6717.261101278856, 6718.798436046926, 6785.253622101565, 5749.54003679713, 5782.624129431658, 5818.2436283282905, 5823.505002074871, 5825.097109947965, 3600.6399360064306, 3624.8006359649944, 3638.6543278388513, 3668.1563240454843, 3670.2659468105953, 6609.504287178481, 6609.702563384659, 6641.867162656817, 6673.132492776005, 6702.36327548882, 6982.650867456607, 6990.860182796418, 6997.9650101750185, 7012.964935175291, 7061.0, 6562.259512078165, 6572.34276572339, 6606.786726446502, 6614.437772789271, 6658.501837086616, 6617.239017513048, 6683.298253683293, 6741.460683145435, 6768.627725474949, 6792.592444453348, 6642.800715978528, 6643.269240383457, 6710.731570737116, 6781.728730850711, 6850.246472887879, 6605.801825945229, 6612.4710023198995, 6649.2685804562425, 6691.0, 6715.3620406061345, 4995.625328100335, 5000.549950504472, 5020.297158397901, 5030.346055012971, 5030.698158110525, 6782.423494003065, 6789.796306110825, 6849.383555480031, 6895.862082758417, 6924.376806087476, 6546.378094081055, 6611.768588099393, 6626.668666566556, 6701.497387696039, 6745.5952642841585, 6315.431611155018, 6499.967500162469, 6542.44389226902, 6626.337366263528, 6631.767888123893, 6168.19813424252, 6319.24169099711, 6407.391297826699, 6468.223813142453, 6523.445507131947, 6510.828050950874, 6539.280679125388, 6540.967295163494, 6592.934070659424, 6688.130543029375, 6344.270408903035, 6355.269144048309, 6379.712912918837, 6455.386738259858, 6514.609123452608], "value": 5102.461770100496, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [922.3082687984012, 930.3766476460771, 937.4609599480297, 943.2359788571262, 954.7040417470582, 19148.329808456707, 19624.313149039786, 19742.210311587554, 19929.501762455944, 20305.898470507665, 21403.0, 21743.13027478899, 22091.447713807163, 22187.66718499224, 22259.332220033426, 1018.9235807314426, 1057.1595581512677, 1059.3749687684265, 1059.6873922192933, 1064.9467526623637, 1016.3241444439439, 1060.2154405739775, 1064.4252103863905, 1064.9361038337686, 1073.0932362153967, 1101.1741194104422, 1107.0313475708756, 1107.2581370481757, 1108.5953626926155, 1110.8944650258213, 1091.5524634899732, 1101.031092638477, 1103.7020004598794, 1106.6679996001208, 1108.7782443511248, 802.5265093594749, 807.1363640904235, 808.623989844725, 809.9716509922124, 810.05628442864, 19156.946367949757, 19351.806481935142, 19362.515937101543, 19810.10854511536, 20297.289594864258, 21180.258690945742, 21466.141354345807, 21679.024443900063, 21710.891445542828, 22109.226177083725, 16352.83647163525, 16371.918140409342, 16621.916890415592, 16633.750493742602, 16637.91681041587, 3687.668109870098, 3711.2763011212824, 3718.6095459976855, 3718.6095459976855, 3720.6093360197333, 126104.0, 126827.0, 128691.0, 129975.35012324972, 130626.0, 16501.504954851374, 16783.748243776354, 16901.23944422504, 16916.492505224618, 17196.0, 31151.844240779104, 31653.8417307912, 31718.0, 32436.189095272806, 32758.34483310368, 7768.300852923264, 8172.387070969582, 8260.421770476129, 8558.700445484377, 8721.60752766127, 4441.622462090694, 4521.773911304487, 4527.071950250191, 4535.7732113394195, 4541.250693635513, 4964.60283177345, 5052.621053421009, 5060.2156665716875, 5097.745112744422, 5123.538881500683, 959.5010594490826, 984.1831280037552, 995.1690338567232, 996.3324572536418, 996.6561536269975, 667.0794303860738, 682.5631595778706, 697.3235961117708, 703.2159142556013, 709.7622296530617, 11579.942100289445, 11906.88093119075, 12015.339156346485, 12122.212056216318, 12435.875641243472, 648.0635481728857, 654.4208375587544, 654.9574277671936, 676.4385559985201, 692.1106378303855, 5699.287589051369, 5705.286839145107, 5748.913766293509, 5790.594658373873, 5864.413558644102, 118188.81811181777, 120233.0, 120545.0, 123159.0, 125912.0, 99777.0, 102417.0, 102703.0, 107172.4641376788, 107756.46121769342, 84735.0, 88301.0, 89029.55485222532, 92195.0, 92439.53780231056, 10512.26414151002, 10562.683119506428, 10563.366198027836, 10786.838197426889, 10794.2983706062, 40157.79921100376, 41123.38314925339, 41299.58700412957, 41553.376699348926, 41705.16589668129, 71816.28183718096, 73352.63323683347, 77288.61355693186, 77361.22638773765, 81034.0, 14898.180600066667, 18224.271029158685, 19166.8083319165, 19181.904090479456, 19573.314933977243, 16783.74824377611, 18206.36277730273, 19296.517587060436, 19631.509212269808, 19842.20631174737, 17005.82994170092, 17037.57406064858, 17145.82854171442, 18105.909470452563, 18236.817631824044, 17759.733603995694, 18360.357387491375, 18361.908190458962, 18405.53986150357, 18506.81493185051, 17342.132893355534, 17628.647427051645, 18679.0, 18722.438326850217, 18886.905565472083, 12831.10182287231, 13352.198868067948, 13358.465661373824, 13370.532031378854, 13434.05961582719, 13527.661808454868, 13610.727785444433, 13813.861861381258, 14037.859621403655, 14147.929260353632], "value": 9273.559718529148, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1511.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 108.0, 101.0, 107.0, 108.0, 110.0, 114.0, 100.0, 107.0, 110.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 116.0, 147.0, 180.0, 124.0, 148.0, 143.0, 124.0, 169.0, 120.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 165.0, 164.0, 164.0, 167.0, 166.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 83.0, 164.0, 75.0, 75.0, 74.0, 86.0, 102.0, 76.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 133.0, 80.0, 78.0, 84.0, 123.0, 79.0, 78.0, 125.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 150.0, 151.0, 151.0, 153.0, 149.0, 150.0, 148.0, 150.0, 151.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 55.0, 55.0, 57.0, 56.0, 55.0, 55.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 56.0, 54.0, 54.0, 59.0, 55.0, 54.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 86.0, 76.0, 74.0, 75.0, 74.0, 74.0, 79.0, 75.0, 84.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 128.0, 129.0, 124.0, 123.0, 129.0, 119.0, 121.0, 137.0, 155.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 168.0, 180.0, 176.0, 175.0, 173.0, 173.0, 181.0, 170.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 68.0, 69.0, 67.0, 71.0, 67.0, 65.0, 65.0, 65.0, 65.0], "value": 68.1, "unit": "score"}]}]} 05:50:35 INFO - Return code: 0 05:50:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:50:35 INFO - # TBPL SUCCESS # 05:50:35 INFO - Running post-action listener: _package_coverage_data 05:50:35 INFO - Running post-action listener: _resource_record_post_action 05:50:35 INFO - [mozharness: 2017-08-21 12:50:35.115725Z] Finished run-tests step (success) 05:50:35 INFO - Running post-run listener: _resource_record_post_run 05:50:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 438996992; Read time: 0; Write time: 389764 05:50:35 INFO - TinderboxPrint: CPU usage
13.1% 05:50:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:50:35 INFO - TinderboxPrint: I/O write bytes / time
438,996,992 / 389,764 05:50:35 INFO - TinderboxPrint: CPU idle
8,254.7 (86.8%) 05:50:35 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 05:50:35 INFO - TinderboxPrint: Swap in / out
0 / 0 05:50:35 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 111542272; Read time: 0; Write time: 129140 05:50:35 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:50:35 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 327454720; Read time: 0; Write time: 260624 05:50:35 INFO - Running post-run listener: _upload_blobber_files 05:50:35 INFO - Blob upload gear active. 05:50:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:50:35 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 05:50:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:50:36 INFO - (blobuploader) - INFO - Open directory for files ... 05:50:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:50:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:50:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:37 INFO - (blobuploader) - INFO - Done attempting. 05:50:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:50:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:50:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:43 INFO - (blobuploader) - INFO - Done attempting. 05:50:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:50:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:50:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:44 INFO - (blobuploader) - INFO - Done attempting. 05:50:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:50:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:50:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:50:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:50:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:50:44 INFO - (blobuploader) - INFO - Done attempting. 05:50:44 INFO - (blobuploader) - INFO - Iteration through files over. 05:50:44 INFO - Return code: 0 05:50:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:50:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:50:44 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/571c97f8d6f64e8e2e80d9d99b864926558b9239f68cc8f8283b0d0684668cae211901fd492ddc3f42c3b9e36bc9fd07525bd3cf9224beaef75a9bda3ac515b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c92b9ae14603b22f0b0e8dff3c0824c01488353e72ba34ae670fc996287d453ca60fd526460346130a30611a8f11a76370327ede024d27ab6c9a0cdb20a056da", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/704504fe19e43d319ad3a624f4da1337b55fce5a9c5c131683c1a056dd6737db204b2082b6fccab6cc3ca684cfd8ad2ded618e07710f7f99b2be14b69772f07d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac124307ee1f73fb9bddbb8cedbb8866cc352c7a87f94867b6d8098528871e3ce84ff4e9f5a95556fbe20c8e5d51c72f725f128ff6b28436d0949e1c21d25019"} 05:50:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:50:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:50:44 INFO - Contents: 05:50:44 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/571c97f8d6f64e8e2e80d9d99b864926558b9239f68cc8f8283b0d0684668cae211901fd492ddc3f42c3b9e36bc9fd07525bd3cf9224beaef75a9bda3ac515b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c92b9ae14603b22f0b0e8dff3c0824c01488353e72ba34ae670fc996287d453ca60fd526460346130a30611a8f11a76370327ede024d27ab6c9a0cdb20a056da", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/704504fe19e43d319ad3a624f4da1337b55fce5a9c5c131683c1a056dd6737db204b2082b6fccab6cc3ca684cfd8ad2ded618e07710f7f99b2be14b69772f07d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac124307ee1f73fb9bddbb8cedbb8866cc352c7a87f94867b6d8098528871e3ce84ff4e9f5a95556fbe20c8e5d51c72f725f128ff6b28436d0949e1c21d25019"} 05:50:44 INFO - Running post-run listener: copy_logs_to_upload_dir 05:50:44 INFO - Copying logs to upload dir... 05:50:44 INFO - mkdir: /builds/slave/test/build/upload/logs 05:50:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.149204 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-21 05:50:44.276506) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 05:50:44.283573) ========= 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=9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/571c97f8d6f64e8e2e80d9d99b864926558b9239f68cc8f8283b0d0684668cae211901fd492ddc3f42c3b9e36bc9fd07525bd3cf9224beaef75a9bda3ac515b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c92b9ae14603b22f0b0e8dff3c0824c01488353e72ba34ae670fc996287d453ca60fd526460346130a30611a8f11a76370327ede024d27ab6c9a0cdb20a056da", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/704504fe19e43d319ad3a624f4da1337b55fce5a9c5c131683c1a056dd6737db204b2082b6fccab6cc3ca684cfd8ad2ded618e07710f7f99b2be14b69772f07d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac124307ee1f73fb9bddbb8cedbb8866cc352c7a87f94867b6d8098528871e3ce84ff4e9f5a95556fbe20c8e5d51c72f725f128ff6b28436d0949e1c21d25019"} build_url:https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/GY_CFQtjQZGJCDtqe6SoTw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/571c97f8d6f64e8e2e80d9d99b864926558b9239f68cc8f8283b0d0684668cae211901fd492ddc3f42c3b9e36bc9fd07525bd3cf9224beaef75a9bda3ac515b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c92b9ae14603b22f0b0e8dff3c0824c01488353e72ba34ae670fc996287d453ca60fd526460346130a30611a8f11a76370327ede024d27ab6c9a0cdb20a056da", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/704504fe19e43d319ad3a624f4da1337b55fce5a9c5c131683c1a056dd6737db204b2082b6fccab6cc3ca684cfd8ad2ded618e07710f7f99b2be14b69772f07d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac124307ee1f73fb9bddbb8cedbb8866cc352c7a87f94867b6d8098528871e3ce84ff4e9f5a95556fbe20c8e5d51c72f725f128ff6b28436d0949e1c21d25019"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 05:50:44.313749) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:50:44.314150) ========= 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=9bfb7e13875ed353a705960e000001c0-1503318574.105341-1121181319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 05:50:44.394060) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 05:50:44.394376) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 05:50:44.394675) ========= ========= Total master_lag: 0.33 =========