builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1503399204.92 results: success (0) revision: db2a49c83d536d38fad916149e43a8fb35121f82 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 03:53:24.917354) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 03:53:24.917838) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 03:53:24.918138) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 03:53:24.944799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 03:53:24.945063) ========= 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=c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-22 03:53:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 74.1K=0.2s 2017-08-22 03:53:25 (74.1 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.327015 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 03:53:25.326017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 03:53:25.326333) ========= 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=c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020923 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 03:53:25.367824) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-22 03:53:25.368163) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev db2a49c83d536d38fad916149e43a8fb35121f82 --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 db2a49c83d536d38fad916149e43a8fb35121f82 --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=c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-22 03:53:25,690 truncating revision to first 12 chars 2017-08-22 03:53:25,690 Setting DEBUG logging. 2017-08-22 03:53:25,690 attempt 1/10 2017-08-22 03:53:25,690 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/db2a49c83d53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-22 03:53:26,853 unpacking tar archive at: mozilla-central-db2a49c83d53/testing/mozharness/ program finished with exit code 0 elapsedTime=1.497855 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-22 03:53:26.902977) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 03:53:26.903269) ========= script_repo_revision: db2a49c83d536d38fad916149e43a8fb35121f82 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 03:53:26.903653) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 03:53:26.903914) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 03:53:26.916514) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-22 03:53:26.916829) ========= /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=c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:53:27 INFO - MultiFileLogger online at 20170822 03:53:27 in /builds/slave/test 03:53:27 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 03:53:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:53:27 INFO - {'append_to_log': False, 03:53:27 INFO - 'base_work_dir': '/builds/slave/test', 03:53:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:53:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:53:27 INFO - 'branch': 'Firefox-Non-PGO', 03:53:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:53:27 INFO - 'code_coverage': False, 03:53:27 INFO - 'config_files': ('talos/linux_config.py',), 03:53:27 INFO - 'default_actions': ('clobber', 03:53:27 INFO - 'read-buildbot-config', 03:53:27 INFO - 'download-and-extract', 03:53:27 INFO - 'populate-webroot', 03:53:27 INFO - 'create-virtualenv', 03:53:27 INFO - 'install', 03:53:27 INFO - 'setup-mitmproxy', 03:53:27 INFO - 'run-tests'), 03:53:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:53:27 INFO - 'disable_ccov_upload': False, 03:53:27 INFO - 'download_minidump_stackwalk': True, 03:53:27 INFO - 'download_symbols': 'ondemand', 03:53:27 INFO - 'enable_stylo': False, 03:53:27 INFO - 'enable_webrender': False, 03:53:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:53:27 INFO - 'tooltool.py': '/tools/tooltool.py', 03:53:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:53:27 INFO - '/tools/misc-python/virtualenv.py')}, 03:53:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:53:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:53:27 INFO - 'gecko_profile': False, 03:53:27 INFO - 'gecko_profile_interval': 0, 03:53:27 INFO - 'installer_path': 'installer.exe', 03:53:27 INFO - 'log_level': 'info', 03:53:27 INFO - 'log_name': 'talos', 03:53:27 INFO - 'log_to_console': True, 03:53:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:53:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:53:27 INFO - 'opt_config_files': (), 03:53:27 INFO - 'pip_index': False, 03:53:27 INFO - 'suite': 'dromaeojs-e10s', 03:53:27 INFO - 'system_bits': '32', 03:53:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:53:27 INFO - 'title': 'talos-linux64-ix-004', 03:53:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:53:27 INFO - 'use_talos_json': True, 03:53:27 INFO - 'verify': 'False', 03:53:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:53:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:53:27 INFO - 'work_dir': 'build'} 03:53:27 INFO - [mozharness: 2017-08-22 10:53:27.360499Z] Running clobber step. 03:53:27 INFO - Running pre-action listener: _resource_record_pre_action 03:53:27 INFO - Running main action method: clobber 03:53:27 INFO - rmtree: /builds/slave/test/build 03:53:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:53:28 INFO - Running post-action listener: _resource_record_post_action 03:53:28 INFO - [mozharness: 2017-08-22 10:53:28.383176Z] Finished clobber step (success) 03:53:28 INFO - [mozharness: 2017-08-22 10:53:28.383274Z] Running read-buildbot-config step. 03:53:28 INFO - Running pre-action listener: _resource_record_pre_action 03:53:28 INFO - Running main action method: read_buildbot_config 03:53:28 INFO - Using buildbot properties: 03:53:28 INFO - { 03:53:28 INFO - "project": "", 03:53:28 INFO - "product": "firefox", 03:53:28 INFO - "who": "archaeopteryx@coole-files.de", 03:53:28 INFO - "installer_path": "public/build/target.tar.bz2", 03:53:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:53:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:53:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:53:28 INFO - "stage_platform": "linux64", 03:53:28 INFO - "basedir": "/builds/slave/test", 03:53:28 INFO - "buildnumber": 784, 03:53:28 INFO - "platform": "ubuntu64_hw", 03:53:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:53:28 INFO - "slavebuilddir": "test", 03:53:28 INFO - "taskId": "VYOlkrMuQXuzx7jY9ryBQA", 03:53:28 INFO - "branch": "mozilla-central", 03:53:28 INFO - "script_repo_revision": "production", 03:53:28 INFO - "revision": "db2a49c83d536d38fad916149e43a8fb35121f82", 03:53:28 INFO - "slavename": "talos-linux64-ix-004", 03:53:28 INFO - "repo_path": "mozilla-central" 03:53:28 INFO - } 03:53:28 INFO - Finding installer, test and symbols from parent task. 03:53:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYOlkrMuQXuzx7jY9ryBQA'}, attempt #1 03:53:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VYOlkrMuQXuzx7jY9ryBQA'}, attempt #1 03:53:29 INFO - Task dependencies: XwXPZh4fRm2LDxf10gD67g 03:53:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g'}, attempt #1 03:53:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.tar.bz2 03:53:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.test_packages.json 03:53:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.crashreporter-symbols.zip 03:53:29 INFO - Running post-action listener: _resource_record_post_action 03:53:29 INFO - [mozharness: 2017-08-22 10:53:29.712671Z] Finished read-buildbot-config step (success) 03:53:29 INFO - [mozharness: 2017-08-22 10:53:29.712889Z] Running download-and-extract step. 03:53:29 INFO - Running pre-action listener: _resource_record_pre_action 03:53:29 INFO - Running main action method: download_and_extract 03:53:29 INFO - mkdir: /builds/slave/test/build/tests 03:53: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')]} 03:53:29 INFO - trying https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.test_packages.json 03:53:29 INFO - Downloading https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:53:30 INFO - Downloaded 989 bytes. 03:53:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:53:30 INFO - Using the following test package requirements: 03:53:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:53:30 INFO - u'common': [u'target.common.tests.zip'], 03:53:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:53:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:53:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:53:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:53:30 INFO - u'mozbase': [u'target.common.tests.zip'], 03:53:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:53:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:53:30 INFO - u'web-platform': [u'target.common.tests.zip', 03:53:30 INFO - u'target.web-platform.tests.tar.gz'], 03:53:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:53:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:53:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.common.tests.zip 03:53:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:53:30 INFO - Fetch https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.common.tests.zip into memory 03:53:31 INFO - Content-Length response header: 54005917 03:53:31 INFO - Bytes received: 54005917 03:53:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:53:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.common.tests.zip 03:53:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:53:42 INFO - Fetch https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.common.tests.zip into memory 03:53:43 INFO - Content-Length response header: 54005917 03:53:43 INFO - Bytes received: 54005917 03:53:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.talos.tests.zip 03:53:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:53:55 INFO - Fetch https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.talos.tests.zip into memory 03:53:56 INFO - Content-Length response header: 14496256 03:53:56 INFO - Bytes received: 14496256 03:53:56 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')]} 03:53:56 INFO - trying https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.tar.bz2 03:53:56 INFO - Downloading https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:53:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:53:57 INFO - Downloaded 62047084 bytes. 03:53:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.tar.bz2 03:53:57 INFO - mkdir: /builds/slave/test/properties 03:53:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:53:57 INFO - Writing to file /builds/slave/test/properties/build_url 03:53:57 INFO - Contents: 03:53:57 INFO - build_url:https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.tar.bz2 03:53:57 INFO - Running post-action listener: _resource_record_post_action 03:53:57 INFO - Running post-action listener: find_tests_for_verification 03:53:57 INFO - Running post-action listener: set_extra_try_arguments 03:53:57 INFO - [mozharness: 2017-08-22 10:53:57.814619Z] Finished download-and-extract step (success) 03:53:57 INFO - [mozharness: 2017-08-22 10:53:57.814717Z] Running populate-webroot step. 03:53:57 INFO - Running pre-action listener: _resource_record_pre_action 03:53:57 INFO - Running main action method: populate_webroot 03:53:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:53:57 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 03:53:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:53:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:53:57 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 03:53:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:53:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:53:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:57 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:53:57 INFO - 'talos_options': ['--stylo'], 03:53:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:53:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:53:57 INFO - 'tests': ['damp', 'tps']}, 03:53:57 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:53:57 INFO - 'talos_options': ['--stylo'], 03:53:57 INFO - 'tests': ['damp', 'tps']}, 03:53:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:53:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:53:57 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 03:53:57 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:53:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:53:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:53:57 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:53:57 INFO - 'talos_options': ['--stylo'], 03:53:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:53:57 INFO - 'other-e10s': {'tests': ['a11yr', 03:53:57 INFO - 'ts_paint', 03:53:57 INFO - 'tpaint', 03:53:57 INFO - 'sessionrestore', 03:53:57 INFO - 'sessionrestore_many_windows', 03:53:57 INFO - 'sessionrestore_no_auto_restore', 03:53:57 INFO - 'tabpaint']}, 03:53:57 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 03:53:57 INFO - 'tests': ['a11yr', 03:53:57 INFO - 'ts_paint', 03:53:57 INFO - 'tpaint', 03:53:57 INFO - 'sessionrestore', 03:53:57 INFO - 'sessionrestore_many_windows', 03:53:57 INFO - 'sessionrestore_no_auto_restore', 03:53:57 INFO - 'tabpaint']}, 03:53:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:53:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:53:57 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 03:53:57 INFO - 'tests': ['bloom_basic_singleton']}, 03:53:57 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 03:53:57 INFO - 'tests': ['bloom_basic']}, 03:53:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:53:57 INFO - 'tsvgr_opacity', 03:53:57 INFO - 'tart', 03:53:57 INFO - 'tscrollx', 03:53:57 INFO - 'tsvg_static']}, 03:53:57 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 03:53:57 INFO - 'tests': ['tsvgx', 03:53:57 INFO - 'tsvgr_opacity', 03:53:57 INFO - 'tart', 03:53:57 INFO - 'tscrollx', 03:53:57 INFO - 'tsvg_static']}, 03:53:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:53:57 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:53:57 INFO - 'talos_options': ['--stylo'], 03:53:57 INFO - 'tests': ['tp5o']}, 03:53:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:53:57 INFO - 'talos_options': ['--mitmproxy', 03:53:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:53:57 INFO - '--firstNonBlankPaint'], 03:53:57 INFO - 'tests': ['tp6_google', 03:53:57 INFO - 'tp6_youtube', 03:53:57 INFO - 'tp6_amazon', 03:53:57 INFO - 'tp6_facebook']}, 03:53:57 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:53:57 INFO - 'talos_options': ['--stylo', 03:53:57 INFO - '--mitmproxy', 03:53:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:53:57 INFO - '--firstNonBlankPaint'], 03:53:57 INFO - 'tests': ['tp6_google', 03:53:57 INFO - 'tp6_youtube', 03:53:57 INFO - 'tp6_amazon', 03:53:57 INFO - 'tp6_facebook']}, 03:53:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:53:57 INFO - 'talos_options': ['--stylo', 03:53:57 INFO - '--stylo-threads=1', 03:53:57 INFO - '--mitmproxy', 03:53:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:53:57 INFO - '--firstNonBlankPaint'], 03:53:57 INFO - 'tests': ['tp6_google', 03:53:57 INFO - 'tp6_youtube', 03:53:57 INFO - 'tp6_amazon', 03:53:57 INFO - 'tp6_facebook']}, 03:53:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:53:57 INFO - 'talos_options': ['--xperf_path', 03:53:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:57 INFO - 'tests': ['tp5n']}, 03:53:57 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 03:53:57 INFO - 'talos_options': ['--stylo', 03:53:57 INFO - '--xperf_path', 03:53:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:53:57 INFO - 'tests': ['tp5n']}}} 03:53:57 INFO - Running post-action listener: _resource_record_post_action 03:53:57 INFO - [mozharness: 2017-08-22 10:53:57.828925Z] Finished populate-webroot step (success) 03:53:57 INFO - [mozharness: 2017-08-22 10:53:57.829014Z] Running create-virtualenv step. 03:53:57 INFO - Running pre-action listener: _resource_record_pre_action 03:53:57 INFO - Running main action method: create_virtualenv 03:53:57 INFO - Creating virtualenv /builds/slave/test/build/venv 03:53:57 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 03:53:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:53:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:53:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:53:57 INFO - Using real prefix '/usr' 03:53:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:53:58 INFO - Installing distribute.............................................................................................................................................................................................done. 03:54:00 INFO - Installing pip.................done. 03:54:00 INFO - Return code: 0 03:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:54:00 INFO - Reading from file tmpfile_stdout 03:54:00 INFO - Output received: 03:54:00 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) 03:54:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:00 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 0xcab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017130>, '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 0x1018030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10184c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', '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 03:54:00 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 03:54:00 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 03:54:00 INFO - Using env: {'DISPLAY': ':0', 03:54:00 INFO - 'HOME': '/home/cltbld', 03:54:00 INFO - 'LANG': 'en_US.UTF-8', 03:54:00 INFO - 'LANGUAGE': 'en_US:en', 03:54:00 INFO - 'LOGNAME': 'cltbld', 03:54:00 INFO - 'MAIL': '/var/mail/cltbld', 03:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:00 INFO - 'MOZ_NO_REMOTE': '1', 03:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:00 INFO - 'NO_EM_RESTART': '1', 03:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:00 INFO - 'PWD': '/builds/slave/test', 03:54:00 INFO - 'SHELL': '/bin/bash', 03:54:00 INFO - 'SHLVL': '1', 03:54:00 INFO - 'TERM': 'linux', 03:54:00 INFO - 'TMOUT': '86400', 03:54:00 INFO - 'USER': 'cltbld', 03:54:00 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', 03:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:00 INFO - '_': '/tools/buildbot/bin/python'} 03:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:00 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 03:54:00 INFO - Cleaning up... 03:54:00 INFO - Return code: 0 03:54:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:00 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 0xcab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017130>, '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 0x1018030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10184c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', '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 03:54:00 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 03:54:00 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 03:54:00 INFO - Using env: {'DISPLAY': ':0', 03:54:00 INFO - 'HOME': '/home/cltbld', 03:54:00 INFO - 'LANG': 'en_US.UTF-8', 03:54:00 INFO - 'LANGUAGE': 'en_US:en', 03:54:00 INFO - 'LOGNAME': 'cltbld', 03:54:00 INFO - 'MAIL': '/var/mail/cltbld', 03:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:00 INFO - 'MOZ_NO_REMOTE': '1', 03:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:00 INFO - 'NO_EM_RESTART': '1', 03:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:00 INFO - 'PWD': '/builds/slave/test', 03:54:00 INFO - 'SHELL': '/bin/bash', 03:54:00 INFO - 'SHLVL': '1', 03:54:00 INFO - 'TERM': 'linux', 03:54:00 INFO - 'TMOUT': '86400', 03:54:00 INFO - 'USER': 'cltbld', 03:54:00 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', 03:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:00 INFO - '_': '/tools/buildbot/bin/python'} 03:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:01 INFO - Downloading/unpacking psutil>=3.1.1 03:54:01 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 03:54:01 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 03:54:01 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 03:54:01 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 03:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:54:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:54:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:54:02 INFO - Installing collected packages: psutil 03:54:02 INFO - Running setup.py install for psutil 03:54:02 INFO - building 'psutil._psutil_linux' extension 03:54:02 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 03:54:02 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 03:54:02 INFO - building 'psutil._psutil_posix' extension 03:54:02 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 03:54:02 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 03:54:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:54:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:54:02 INFO - Successfully installed psutil 03:54:02 INFO - Cleaning up... 03:54:02 INFO - Return code: 0 03:54:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:54:02 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')]} 03:54:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:02 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')]} 03:54:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:02 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 0xcab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017130>, '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 0x1018030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10184c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', '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 03:54:02 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 03:54:02 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 03:54:02 INFO - Using env: {'DISPLAY': ':0', 03:54:02 INFO - 'HOME': '/home/cltbld', 03:54:02 INFO - 'LANG': 'en_US.UTF-8', 03:54:02 INFO - 'LANGUAGE': 'en_US:en', 03:54:02 INFO - 'LOGNAME': 'cltbld', 03:54:02 INFO - 'MAIL': '/var/mail/cltbld', 03:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:02 INFO - 'MOZ_NO_REMOTE': '1', 03:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:02 INFO - 'NO_EM_RESTART': '1', 03:54:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:02 INFO - 'PWD': '/builds/slave/test', 03:54:02 INFO - 'SHELL': '/bin/bash', 03:54:02 INFO - 'SHLVL': '1', 03:54:02 INFO - 'TERM': 'linux', 03:54:02 INFO - 'TMOUT': '86400', 03:54:02 INFO - 'USER': 'cltbld', 03:54:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', 03:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:02 INFO - '_': '/tools/buildbot/bin/python'} 03:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:54:03 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 03:54:03 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 03:54:03 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 03:54:03 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 03:54:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:54:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:54:05 INFO - Installing collected packages: mozsystemmonitor 03:54:05 INFO - Running setup.py install for mozsystemmonitor 03:54:05 INFO - Successfully installed mozsystemmonitor 03:54:05 INFO - Cleaning up... 03:54:05 INFO - Return code: 0 03:54:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xcab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017130>, '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 0x1018030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10184c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', '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 03:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:54:05 INFO - Using env: {'DISPLAY': ':0', 03:54:05 INFO - 'HOME': '/home/cltbld', 03:54:05 INFO - 'LANG': 'en_US.UTF-8', 03:54:05 INFO - 'LANGUAGE': 'en_US:en', 03:54:05 INFO - 'LOGNAME': 'cltbld', 03:54:05 INFO - 'MAIL': '/var/mail/cltbld', 03:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:05 INFO - 'MOZ_NO_REMOTE': '1', 03:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:05 INFO - 'NO_EM_RESTART': '1', 03:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:05 INFO - 'PWD': '/builds/slave/test', 03:54:05 INFO - 'SHELL': '/bin/bash', 03:54:05 INFO - 'SHLVL': '1', 03:54:05 INFO - 'TERM': 'linux', 03:54:05 INFO - 'TMOUT': '86400', 03:54:05 INFO - 'USER': 'cltbld', 03:54:05 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', 03:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:05 INFO - '_': '/tools/buildbot/bin/python'} 03:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:06 INFO - Downloading/unpacking jsonschema==2.5.1 03:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:54:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:54:07 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 03:54:07 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 03:54:07 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 03:54:07 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 03:54:07 INFO - Downloading functools32-3.2.3-2.tar.gz 03:54:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:54:07 INFO - warning: no files found matching '*.txt' 03:54:07 INFO - no previously-included directories found matching 'build' 03:54:07 INFO - no previously-included directories found matching 'dist' 03:54:07 INFO - no previously-included directories found matching '.git*' 03:54:07 INFO - Installing collected packages: jsonschema, functools32 03:54:07 INFO - Running setup.py install for functools32 03:54:07 INFO - warning: no files found matching '*.txt' 03:54:07 INFO - no previously-included directories found matching 'build' 03:54:07 INFO - no previously-included directories found matching 'dist' 03:54:07 INFO - no previously-included directories found matching '.git*' 03:54:07 INFO - Successfully installed jsonschema functools32 03:54:07 INFO - Cleaning up... 03:54:07 INFO - Return code: 0 03:54:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:07 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 0xcab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017130>, '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 0x1018030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10184c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', '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 03:54:07 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 03:54:07 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 03:54:07 INFO - Using env: {'DISPLAY': ':0', 03:54:07 INFO - 'HOME': '/home/cltbld', 03:54:07 INFO - 'LANG': 'en_US.UTF-8', 03:54:07 INFO - 'LANGUAGE': 'en_US:en', 03:54:07 INFO - 'LOGNAME': 'cltbld', 03:54:07 INFO - 'MAIL': '/var/mail/cltbld', 03:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:07 INFO - 'MOZ_NO_REMOTE': '1', 03:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:07 INFO - 'NO_EM_RESTART': '1', 03:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:07 INFO - 'PWD': '/builds/slave/test', 03:54:07 INFO - 'SHELL': '/bin/bash', 03:54:07 INFO - 'SHLVL': '1', 03:54:07 INFO - 'TERM': 'linux', 03:54:07 INFO - 'TMOUT': '86400', 03:54:07 INFO - 'USER': 'cltbld', 03:54:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', 03:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:07 INFO - '_': '/tools/buildbot/bin/python'} 03:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:54:07 INFO - Cleaning up... 03:54:07 INFO - Return code: 0 03:54:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:07 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 0xcab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017130>, '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 0x1018030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10184c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', '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 03:54:07 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 03:54:07 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 03:54:07 INFO - Using env: {'DISPLAY': ':0', 03:54:07 INFO - 'HOME': '/home/cltbld', 03:54:07 INFO - 'LANG': 'en_US.UTF-8', 03:54:07 INFO - 'LANGUAGE': 'en_US:en', 03:54:07 INFO - 'LOGNAME': 'cltbld', 03:54:07 INFO - 'MAIL': '/var/mail/cltbld', 03:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:07 INFO - 'MOZ_NO_REMOTE': '1', 03:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:07 INFO - 'NO_EM_RESTART': '1', 03:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:07 INFO - 'PWD': '/builds/slave/test', 03:54:07 INFO - 'SHELL': '/bin/bash', 03:54:07 INFO - 'SHLVL': '1', 03:54:07 INFO - 'TERM': 'linux', 03:54:07 INFO - 'TMOUT': '86400', 03:54:07 INFO - 'USER': 'cltbld', 03:54:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', 03:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:07 INFO - '_': '/tools/buildbot/bin/python'} 03:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:07 INFO - Downloading/unpacking blobuploader==1.2.4 03:54:07 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 03:54:07 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 03:54:07 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 03:54:07 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 03:54:09 INFO - Downloading blobuploader-1.2.4.tar.gz 03:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:54:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:54:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:09 INFO - Downloading docopt-0.6.1.tar.gz 03:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:54:09 INFO - Installing collected packages: blobuploader, requests, docopt 03:54:09 INFO - Running setup.py install for blobuploader 03:54:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:54:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:54:09 INFO - Running setup.py install for requests 03:54:10 INFO - Running setup.py install for docopt 03:54:10 INFO - Successfully installed blobuploader requests docopt 03:54:10 INFO - Cleaning up... 03:54:10 INFO - Return code: 0 03:54:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:10 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 0xcab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017130>, '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 0x1018030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10184c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', '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 03:54:10 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 03:54:10 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 03:54:10 INFO - Using env: {'DISPLAY': ':0', 03:54:10 INFO - 'HOME': '/home/cltbld', 03:54:10 INFO - 'LANG': 'en_US.UTF-8', 03:54:10 INFO - 'LANGUAGE': 'en_US:en', 03:54:10 INFO - 'LOGNAME': 'cltbld', 03:54:10 INFO - 'MAIL': '/var/mail/cltbld', 03:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:10 INFO - 'MOZ_NO_REMOTE': '1', 03:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:10 INFO - 'NO_EM_RESTART': '1', 03:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:10 INFO - 'PWD': '/builds/slave/test', 03:54:10 INFO - 'SHELL': '/bin/bash', 03:54:10 INFO - 'SHLVL': '1', 03:54:10 INFO - 'TERM': 'linux', 03:54:10 INFO - 'TMOUT': '86400', 03:54:10 INFO - 'USER': 'cltbld', 03:54:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', 03:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:10 INFO - '_': '/tools/buildbot/bin/python'} 03:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:54:10 INFO - Running setup.py (path:/tmp/pip-PUvd_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:54:10 INFO - Running setup.py (path:/tmp/pip-UztQwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:54:10 INFO - Running setup.py (path:/tmp/pip-n64Kqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:54:10 INFO - Running setup.py (path:/tmp/pip-So0K0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:54:10 INFO - Running setup.py (path:/tmp/pip-NyS2Jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:54:10 INFO - Running setup.py (path:/tmp/pip-ans74E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:54:10 INFO - Running setup.py (path:/tmp/pip-4Ri2IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:54:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:54:10 INFO - Running setup.py (path:/tmp/pip-hM6u6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:54:11 INFO - Running setup.py (path:/tmp/pip-6kHr0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:54:11 INFO - Running setup.py (path:/tmp/pip-UAjRVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:54:11 INFO - Running setup.py (path:/tmp/pip-ijzmjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:54:11 INFO - Running setup.py (path:/tmp/pip-KzKeKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:54:11 INFO - Running setup.py (path:/tmp/pip-Wfuv2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:54:11 INFO - Running setup.py (path:/tmp/pip-g4LZMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:11 INFO - Running setup.py (path:/tmp/pip-R4aZ0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:54:11 INFO - Running setup.py (path:/tmp/pip-9nriBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:54:11 INFO - Running setup.py (path:/tmp/pip-MnbdtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:54:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:54:11 INFO - Running setup.py install for manifestparser 03:54:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:54:11 INFO - Running setup.py install for mozcrash 03:54:11 INFO - Running setup.py install for mozdebug 03:54:11 INFO - Running setup.py install for mozdevice 03:54:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:54:12 INFO - Running setup.py install for mozfile 03:54:12 INFO - Running setup.py install for mozhttpd 03:54:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:54:12 INFO - Running setup.py install for mozinfo 03:54:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:54:12 INFO - Running setup.py install for mozInstall 03:54:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:54:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:54:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:54:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:54:12 INFO - Running setup.py install for mozleak 03:54:12 INFO - Running setup.py install for mozlog 03:54:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:54:12 INFO - Running setup.py install for moznetwork 03:54:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:54:12 INFO - Running setup.py install for mozprocess 03:54:12 INFO - Running setup.py install for mozprofile 03:54:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:54:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:54:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:54:13 INFO - Running setup.py install for mozrunner 03:54:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:54:13 INFO - Running setup.py install for mozscreenshot 03:54:13 INFO - Running setup.py install for moztest 03:54:13 INFO - Running setup.py install for mozversion 03:54:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:54:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:54:13 INFO - Cleaning up... 03:54:13 INFO - Return code: 0 03:54:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:13 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 0xcab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017130>, '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 0x1018030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10184c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', '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 03:54:13 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 03:54:13 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 03:54:13 INFO - Using env: {'DISPLAY': ':0', 03:54:13 INFO - 'HOME': '/home/cltbld', 03:54:13 INFO - 'LANG': 'en_US.UTF-8', 03:54:13 INFO - 'LANGUAGE': 'en_US:en', 03:54:13 INFO - 'LOGNAME': 'cltbld', 03:54:13 INFO - 'MAIL': '/var/mail/cltbld', 03:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:13 INFO - 'MOZ_NO_REMOTE': '1', 03:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:13 INFO - 'NO_EM_RESTART': '1', 03:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:13 INFO - 'PWD': '/builds/slave/test', 03:54:13 INFO - 'SHELL': '/bin/bash', 03:54:13 INFO - 'SHLVL': '1', 03:54:13 INFO - 'TERM': 'linux', 03:54:13 INFO - 'TMOUT': '86400', 03:54:13 INFO - 'USER': 'cltbld', 03:54:13 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', 03:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:13 INFO - '_': '/tools/buildbot/bin/python'} 03:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:54:13 INFO - Running setup.py (path:/tmp/pip-sKfTpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:54:13 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)) 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:54:13 INFO - Running setup.py (path:/tmp/pip-d13AcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:54:13 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)) 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:54:13 INFO - Running setup.py (path:/tmp/pip-gsVd3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:54:13 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)) 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:54:13 INFO - Running setup.py (path:/tmp/pip-aayLFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:54:13 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)) 03:54:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:54:13 INFO - Running setup.py (path:/tmp/pip-njYlLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:54:14 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)) 03:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:54:14 INFO - Running setup.py (path:/tmp/pip-g_MbTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:54:14 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)) 03:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:54:14 INFO - Running setup.py (path:/tmp/pip-Z9zhiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:54:14 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)) 03:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:54:14 INFO - Running setup.py (path:/tmp/pip-jnQxpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:54:14 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)) 03:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:54:14 INFO - Running setup.py (path:/tmp/pip-WsEQdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:54:14 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)) 03:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:54:14 INFO - Running setup.py (path:/tmp/pip-Ong_nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:54:14 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)) 03:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:54:14 INFO - Running setup.py (path:/tmp/pip-oL41LP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:54:14 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)) 03:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:54:14 INFO - Running setup.py (path:/tmp/pip-8U2YsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:54:14 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)) 03:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:54:14 INFO - Running setup.py (path:/tmp/pip-YVbL3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:54:14 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)) 03:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:54:14 INFO - Running setup.py (path:/tmp/pip-jkFXW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:54:14 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)) 03:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:14 INFO - Running setup.py (path:/tmp/pip-Gm9S_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:54:14 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)) 03:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:54:14 INFO - Running setup.py (path:/tmp/pip-vdKZRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:54:14 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)) 03:54:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:54:14 INFO - Running setup.py (path:/tmp/pip-nmAKle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:54:14 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)) 03:54:14 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)) 03:54:14 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)) 03:54:14 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)) 03:54:14 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)) 03:54:14 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)) 03:54:14 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)) 03:54:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:54:14 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 03:54:14 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 03:54:14 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 03:54:14 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 03:54:16 INFO - Downloading blessings-1.6.tar.gz 03:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:54:16 INFO - Installing collected packages: blessings 03:54:16 INFO - Running setup.py install for blessings 03:54:16 INFO - Successfully installed blessings 03:54:16 INFO - Cleaning up... 03:54:16 INFO - Return code: 0 03:54:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:54:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:54:16 INFO - Reading from file tmpfile_stdout 03:54:16 INFO - Current package versions: 03:54:16 INFO - argparse == 1.2.1 03:54:16 INFO - blessings == 1.6 03:54:16 INFO - blobuploader == 1.2.4 03:54:16 INFO - docopt == 0.6.1 03:54:16 INFO - functools32 == 3.2.3-2 03:54:16 INFO - jsonschema == 2.5.1 03:54:16 INFO - manifestparser == 1.1 03:54:16 INFO - mozInstall == 1.13 03:54:16 INFO - mozcrash == 1.0 03:54:16 INFO - mozdebug == 0.1 03:54:16 INFO - mozdevice == 0.51 03:54:16 INFO - mozfile == 1.2 03:54:16 INFO - mozhttpd == 0.7 03:54:16 INFO - mozinfo == 0.10 03:54:16 INFO - mozleak == 0.1 03:54:16 INFO - mozlog == 3.5 03:54:16 INFO - moznetwork == 0.27 03:54:16 INFO - mozprocess == 0.25 03:54:16 INFO - mozprofile == 0.28 03:54:16 INFO - mozrunner == 6.13 03:54:16 INFO - mozscreenshot == 0.1 03:54:16 INFO - mozsystemmonitor == 0.3 03:54:16 INFO - moztest == 0.8 03:54:16 INFO - mozversion == 1.4 03:54:16 INFO - psutil == 3.1.1 03:54:16 INFO - requests == 1.2.3 03:54:16 INFO - wsgiref == 0.1.2 03:54:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:16 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 0xcab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017130>, '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 0x1018030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10184c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', '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 03:54:16 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 03:54:16 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 03:54:16 INFO - Using env: {'DISPLAY': ':0', 03:54:16 INFO - 'HOME': '/home/cltbld', 03:54:16 INFO - 'LANG': 'en_US.UTF-8', 03:54:16 INFO - 'LANGUAGE': 'en_US:en', 03:54:16 INFO - 'LOGNAME': 'cltbld', 03:54:16 INFO - 'MAIL': '/var/mail/cltbld', 03:54:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:16 INFO - 'MOZ_NO_REMOTE': '1', 03:54:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:16 INFO - 'NO_EM_RESTART': '1', 03:54:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:16 INFO - 'PWD': '/builds/slave/test', 03:54:16 INFO - 'SHELL': '/bin/bash', 03:54:16 INFO - 'SHLVL': '1', 03:54:16 INFO - 'TERM': 'linux', 03:54:16 INFO - 'TMOUT': '86400', 03:54:16 INFO - 'USER': 'cltbld', 03:54:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', 03:54:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:16 INFO - '_': '/tools/buildbot/bin/python'} 03:54:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:16 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)) 03:54:16 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)) 03:54:16 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)) 03:54:16 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)) 03:54:16 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)) 03:54:16 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)) 03:54:16 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)) 03:54:16 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)) 03:54:16 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)) 03:54:16 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:54:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:54:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:54:17 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)) 03:54:17 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)) 03:54:17 INFO - Installing collected packages: simplejson 03:54:17 INFO - Running setup.py install for simplejson 03:54:17 INFO - building 'simplejson._speedups' extension 03:54:17 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 03:54:18 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 03:54:18 INFO - Successfully installed simplejson 03:54:18 INFO - Cleaning up... 03:54:18 INFO - Return code: 0 03:54:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:54:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:54:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:54:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:54:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcab1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe76a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1019f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017130>, '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 0x1018030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10184c0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', '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 03:54:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:54:18 INFO - Using env: {'DISPLAY': ':0', 03:54:18 INFO - 'HOME': '/home/cltbld', 03:54:18 INFO - 'LANG': 'en_US.UTF-8', 03:54:18 INFO - 'LANGUAGE': 'en_US:en', 03:54:18 INFO - 'LOGNAME': 'cltbld', 03:54:18 INFO - 'MAIL': '/var/mail/cltbld', 03:54:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:18 INFO - 'MOZ_NO_REMOTE': '1', 03:54:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:18 INFO - 'NO_EM_RESTART': '1', 03:54:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:18 INFO - 'PWD': '/builds/slave/test', 03:54:18 INFO - 'SHELL': '/bin/bash', 03:54:18 INFO - 'SHLVL': '1', 03:54:18 INFO - 'TERM': 'linux', 03:54:18 INFO - 'TMOUT': '86400', 03:54:18 INFO - 'USER': 'cltbld', 03:54:18 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', 03:54:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:18 INFO - '_': '/tools/buildbot/bin/python'} 03:54:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:54:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:54:19 INFO - Cleaning up... 03:54:19 INFO - Return code: 0 03:54:19 INFO - Running post-action listener: _resource_record_post_action 03:54:19 INFO - Running post-action listener: _start_resource_monitoring 03:54:19 INFO - Starting resource monitoring. 03:54:19 INFO - [mozharness: 2017-08-22 10:54:19.168536Z] Finished create-virtualenv step (success) 03:54:19 INFO - [mozharness: 2017-08-22 10:54:19.169003Z] Running install step. 03:54:19 INFO - Running pre-action listener: _resource_record_pre_action 03:54:19 INFO - Running main action method: install 03:54:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:54:19 INFO - Reading from file tmpfile_stdout 03:54:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:54:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:54:19 INFO - Reading from file tmpfile_stdout 03:54:19 INFO - Output received: 03:54:19 INFO - Usage: mozinstall [options] installer 03:54:19 INFO - Options: 03:54:19 INFO - -h, --help show this help message and exit 03:54:19 INFO - -d DEST, --destination=DEST 03:54:19 INFO - Directory to install application into. [default: 03:54:19 INFO - "/builds/slave/test"] 03:54:19 INFO - --app=APP Application being installed. [default: firefox] 03:54:19 INFO - mkdir: /builds/slave/test/build/application 03:54:19 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'] 03:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:54:37 INFO - Reading from file tmpfile_stdout 03:54:37 INFO - Output received: 03:54:37 INFO - /builds/slave/test/build/application/firefox/firefox 03:54:37 INFO - Running post-action listener: _resource_record_post_action 03:54:37 INFO - [mozharness: 2017-08-22 10:54:37.514328Z] Finished install step (success) 03:54:37 INFO - [mozharness: 2017-08-22 10:54:37.514611Z] Running setup-mitmproxy step. 03:54:37 INFO - Running pre-action listener: _resource_record_pre_action 03:54:37 INFO - Running main action method: setup_mitmproxy 03:54:37 INFO - Skipping: mitmproxy is not required 03:54:37 INFO - Running post-action listener: _resource_record_post_action 03:54:37 INFO - [mozharness: 2017-08-22 10:54:37.515857Z] Finished setup-mitmproxy step (success) 03:54:37 INFO - [mozharness: 2017-08-22 10:54:37.516077Z] Running run-tests step. 03:54:37 INFO - Running pre-action listener: _resource_record_pre_action 03:54:37 INFO - Running pre-action listener: _set_gcov_prefix 03:54:37 INFO - Running main action method: run_tests 03:54:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:54:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:54:37 INFO - Python 2.7.3 03:54:37 INFO - Return code: 0 03:54:37 INFO - grabbing minidump binary from tooltool 03:54: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')]} 03:54:37 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 0x1017130>, '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 0x1018030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10184c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:54:37 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 03:54:37 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 03:54:37 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 03:54:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:54:37 INFO - Return code: 0 03:54:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:54:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:54:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:54:37 INFO - ENV: RUST_BACKTRACE is now full 03:54:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:54:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:54:37 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/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 03:54:37 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/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 03:54:37 INFO - Using env: {'DISPLAY': ':0', 03:54:37 INFO - 'HOME': '/home/cltbld', 03:54:37 INFO - 'LANG': 'en_US.UTF-8', 03:54:37 INFO - 'LANGUAGE': 'en_US:en', 03:54:37 INFO - 'LOGNAME': 'cltbld', 03:54:37 INFO - 'MAIL': '/var/mail/cltbld', 03:54:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:54:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:54:37 INFO - 'MOZ_NO_REMOTE': '1', 03:54:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:54:37 INFO - 'NO_EM_RESTART': '1', 03:54:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:54:37 INFO - 'PWD': '/builds/slave/test', 03:54:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:54:37 INFO - 'RUST_BACKTRACE': 'full', 03:54:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:54:37 INFO - 'SHELL': '/bin/bash', 03:54:37 INFO - 'SHLVL': '1', 03:54:37 INFO - 'TERM': 'linux', 03:54:37 INFO - 'TMOUT': '86400', 03:54:37 INFO - 'USER': 'cltbld', 03:54:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322', 03:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:54:37 INFO - '_': '/tools/buildbot/bin/python'} 03:54:37 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/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 03:54:37 INFO - mozversion application_buildid: 20170822094747 03:54:37 INFO - mozversion application_changeset: db2a49c83d536d38fad916149e43a8fb35121f82 03:54:37 INFO - mozversion application_display_name: Nightly 03:54:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:54:37 INFO - mozversion application_name: Firefox 03:54:37 INFO - mozversion application_remotingname: firefox 03:54:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:54:37 INFO - mozversion application_vendor: Mozilla 03:54:37 INFO - mozversion application_version: 57.0a1 03:54:37 INFO - mozversion platform_buildid: 20170822094747 03:54:37 INFO - mozversion platform_changeset: db2a49c83d536d38fad916149e43a8fb35121f82 03:54:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:54:37 INFO - mozversion platform_version: 57.0a1 03:54:37 INFO - using testdate: 1503399277 03:54:37 INFO - actual date: 1503399277 03:54:37 INFO - starting webserver on 'localhost:33926' 03:54:37 INFO - SUITE-START | Running 2 tests 03:54:37 INFO - TEST-START | dromaeo_css 03:54:37 INFO - Initialising browser for dromaeo_css test... 03:54:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33926/getInfo.html -profile /tmp/tmp8vj0HA/profile 03:54:37 INFO - TEST-INFO | started process 8413 (/builds/slave/test/build/application/firefox/firefox http://localhost:33926/getInfo.html) 03:54:43 INFO - TEST-INFO | 8413: exit 0 03:54:43 INFO - Browser initialized. 03:54:43 INFO - Running cycle 1/1 for dromaeo_css test... 03:54:43 INFO - TEST-INFO | started process 8591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8vj0HA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:54:44 INFO - PID 8591 | 03:54:44 INFO - PID 8591 | (/builds/slave/test/build/application/firefox/firefox:8640): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:54:44 INFO - PID 8591 | 03:54:45 INFO - PID 8591 | 03:54:45 INFO - PID 8591 | (/builds/slave/test/build/application/firefox/firefox:8693): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:54:45 INFO - PID 8591 | 03:54:45 INFO - PID 8591 | __metrics Screen width/height:1600/1200 03:54:45 INFO - PID 8591 | colorDepth:24 03:54:45 INFO - PID 8591 | Browser inner width/height: 1024/768 03:54:45 INFO - PID 8591 | __metrics 03:54:54 INFO - PID 8591 | RSS: Main: 171966464 03:54:54 INFO - PID 8591 | 03:57:53 INFO - PID 8591 | Cycle 1(1): loaded http://localhost:33926/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33926/tests/dromaeo/cssquery-ext.html) 03:57:55 INFO - PID 8591 | RSS: Main: 175886336 03:57:55 INFO - PID 8591 | 04:00:57 INFO - PID 8591 | Cycle 1(1): loaded http://localhost:33926/tests/dromaeo/cssquery-ext.html (next: http://localhost:33926/tests/dromaeo/cssquery-jquery.html) 04:00:57 INFO - PID 8591 | RSS: Main: 172093440 04:00:57 INFO - PID 8591 | 04:03:59 INFO - PID 8591 | Cycle 1(1): loaded http://localhost:33926/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33926/tests/dromaeo/cssquery-mootools.html) 04:03:59 INFO - PID 8591 | RSS: Main: 174526464 04:03:59 INFO - PID 8591 | 04:07:01 INFO - PID 8591 | Cycle 1(1): loaded http://localhost:33926/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33926/tests/dromaeo/cssquery-prototype.html) 04:07:02 INFO - PID 8591 | RSS: Main: 172859392 04:07:02 INFO - PID 8591 | 04:10:05 INFO - PID 8591 | Cycle 1(1): loaded http://localhost:33926/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33926/tests/dromaeo/cssquery-yui.html) 04:10:06 INFO - PID 8591 | RSS: Main: 176291840 04:10:06 INFO - PID 8591 | 04:13:07 INFO - PID 8591 | Cycle 1(1): loaded http://localhost:33926/tests/dromaeo/cssquery-yui.html (next: http://localhost:33926/tests/dromaeo/cssquery-dojo.html) 04:13:08 INFO - PID 8591 | RSS: Main: 176689152 04:13:08 INFO - PID 8591 | 04:13:08 INFO - PID 8591 | __start_tp_report 04:13:08 INFO - PID 8591 | _x_x_mozilla_page_load 04:13:08 INFO - PID 8591 | _x_x_mozilla_page_load_details 04:13:08 INFO - PID 8591 | |i|pagename|runs| 04:13:08 INFO - PID 8591 | |0;dojo.html;3097.0399176255364;3118.2827949571597;3133.32633483801;3133.3733253349337;3159.968400315996;6108.4197001284865;6199.44205021548;6223.595466294688;6246.437820596146;6336.778212762554;6253.093301471284;6277;6337.936620633793;6340.3976622220935;6376.9362306376925;5646.858828529279;5673.978683836907;5693.174489698991;5783.797567085153;5812.854678633047;5587.944120558804;5642.633228840113;5702.572307076965;5770.134479828017;5785.884282314372;5622.4939755422;5705.971470142665;5724.341700704431;5732.770689172428;5738.512226460735;5648;5656.264685590888;5753.769849206027;5765.740541675593;5771.769129234825;5644.520215781622;5646.350669672999;5681.630694004876;5716.542676585905;5730.398308177623;6132.049532322497;6147.2008638877105;6157;6161.44546990773;6234.438900498977;6645.102911106987;6667.533272670915;6739.6293203873765;6756.223034351064;6769.966150169267;6657.201135863679;6700.966495167541;6717.966410167966;6817.284185160586;6826.897596536056;6181.598196117238;6246.656433896134;6250.124982502453;6261.248650161964;6265.154204182422;6725.764598239136;6823.965880170567;6832.111825462658;6901;6912;6484.286728459866;6510.674466276667;6519;6531.314212007671;6537.836554086186;6598.769043083469;6603.273639899608;6603.7358505660195;6606.6036037837885;6608.2730899601;6443.581167224115;6629.635370054597;6663.900041499382;6669.666516674244;6674.232463266787;6654.101696271038;6659.367360100783;6743.662816859138;6749.527533072736;6763.256041835394;5428.240046393508;5440.700761458158;5490.972545137249;5504.889902201933;5516.641418307797;4579.450465944108;4643.141018911445;4660.231061874821;4672.789724462407;4719.1033703596895;5843.5909486336395;5846.239988801429;5851.941480585139;5854.648721076749;5862.560307976919;6659.134312539339;6674;6764.763233286812;6774.051632771318;6780.1524809398825;5734.598578099493;5735.254416925856;5807.157962095473;5807.419258074159;5822.243108395882;5826.213461182686;5886.058230683156;5945.970270148621;5947.672877991666;5960.105984102419;6502.739890404331;6514.283428822826;6516.152900122954;6542.411182993554;6545.5090868184125;6609.702563384755;6723.7310507581105;6773.491988100814;6780.72877084911;6787.660616969033;6440.25937017249;6447;6481.675916204265;6516.478681705357;6541.08424820516;6557.836054098495;6562.934370656232;6569.967150164219;6574.868502629825;6581.14445122131;6701.0953521274005;6705.698243579148;6780;6801.421879140328;6810.897836532555;6442.742290308335;6448.806535803933;6472.5145614080075;6551.918933376131;6557.180352455943;6361.650109244036;6470.579412338371;6492.253390860112;6516.771912983023;6539.901901471577;6508.186476690414;6517.9348206517325;6521.608703477807;6525.706343214471;6529.640869752209;6394.584352017104;6426.742930282736;6510.218773746991;6624.403803657694;6656.866862662817;6361.777337793155;6369.936300636934;6370.936290637034;6384.936150638434;6392.20097487814 04:13:08 INFO - PID 8591 | |1;ext.html;729.3180875881052;796.5220867479513;827.3670641958903;1166.1079274355116;1186.2170967161676;32065.67934320656;32765.18087047825;32789.67210327899;42708.14583708324;43672;43898.34152487715;44305.335419968644;44358.33462498057;44397;44401.55598444014;7369.520981136236;7617.619119044053;7909.446338756289;7910.644021019039;7912.683492660315;7736.226377362275;7788.922110778876;7791.181925897784;7843.21567843214;7844.333231675315;7793.376529877624;7846.843063138734;7853.764387068397;7857.8035549111155;7862;7791.844163116734;7820.804479887991;7823.2176782321885;7824.1002284737415;7847;7687.654055567513;7739.883901741478;7743.8451230975625;7744.7676569703;7746.883796743054;40085.79957100225;40096.39855402171;40122.79938600288;40131.7993410034;40269;3493.353729560014;3495.07380544156;3526.806025668587;3530.5763308402898;3536.9646303536892;32006.6799332006;32234.516482252784;32303.192420189447;32427.18932026718;32469.51295730566;4986.376702912136;5134.512221339004;5151.072806894757;5169.586433085344;5171.965606878602;199938;200169;201102;201429;201548;50118.49881501211;50189.498105019215;50201;50281.74859125681;50283.74858125686;52253.7387313061;52362.476375236525;52402.73798631059;52458.47541524536;52481.737591312565;14673.413063477556;16002.519924402053;16446.588835279214;16447;16455.177241138135;12310.322932238634;13245.933770331087;13562.864371356358;13588.59234222975;13613.183209007491;14814.703705925822;14821.777673334693;14842.332095055532;14882.181480018486;14896.255187240595;5831.825045248649;5879.559033072536;5967.343592204854;6003.129546215774;6004.819855404345;980.8283550378655;996.5166894056376;997.9900200997897;1012.731626119079;1023.4217667018111;23179.420514487272;23326.300210993697;23384.298471045895;23430;23814.7618523816;1085.1861104171871;1086.788076325109;1088.2382332367374;1096.4079397125463;1103.9613613523488;12231.266124032587;12314.81527777084;12424.503019879285;12491.625251242478;12525.31110788897;216193;216711;218018;218064;218956;55283.72358138183;55655;55791;55867.44132558704;55997.1600425994;1437.978430323546;1460.70785842834;1487.910725356482;1488.6204017975563;1491.2022068193464;22733.431664207867;22794.43013924599;23011.309660710205;23078.307650770505;23318.65022024637;38096.23807523889;38196.61803382042;38236.42645360266;38275.23449531049;38328.42507362336;189158;189195;189548;190340;190924;34415.82792086023;36811.447828282064;37403.81298093492;37621;37759.244815104095;47949.5205047959;49531.50468495269;49853.75073124611;49903.75048124736;50115;34991.12522186965;35587.82206088953;35880.282394351445;36083.63916360803;36186.638133618326;34456.48315275323;35097.47353789644;35113;35316.646833532366;35424;38244.426333605574;38493;38568.228635427695;38932.41601376038;39018.2196356077;33674.83162584171;33785.3242935135;34224.144396389296;34556.30887382288;35641.46537801883;24382.146624868044;24396.390090247885;24846.751532484443;25287.87356063208;25316.36709082214 04:13:08 INFO - PID 8591 | |2;jquery.html;566.1281626295505;569.2087997683218;573.7590212110914;575.0224618149144;592.6740292838939;22054.117835286568;22516.09935602576;23303.300900972954;23310.300690979257;23338.999999999978;25865.482690346184;26519.469610607775;26538.6019209712;26546.601800973;26611;6271.247450305969;6390.201224846895;6392.616443013434;6396.61620302781;6404.359564043605;6061.878762424749;6467.256265529454;6521.380468855451;6584.868302633944;6651.600903945779;6593.934060659404;6597.142371491699;6597.769078082268;6602.801915942529;6605.273419923805;6566.8686626267445;6573.835654108638;6583.2429270633775;6597.208334999783;6598.571092878948;6116.724747386378;6148.446639802394;6154.323024467305;6157.168782214389;6162.7226774795245;29447.852760736274;30544.389112217632;30630;30876;30953.53569696456;1992.392320342295;2025.2506572568243;2025.3923822853085;2027.0675489274952;2027.2499175305084;19602.70595941062;20163.294284699965;20169;20172.899135504376;20177.79822201774;2437.731849496554;2441;2450.3506570758764;2477.5664258754646;2522.092046863128;142085;143861.28069359585;147617;148218.25890870584;148268;14855.2572371381;14878;15235.162066086472;15465.768013479581;15835.208239587975;23367.298981030595;23842.523149537257;24157.637635435483;24160.87919560391;24198.274051778473;10207.213737595892;10214.642487512901;10302.33034852732;10306.948465257776;10487.423191724529;9398.34211605181;9405.294602904809;9416;9551.42691438502;9575.318910705013;9396.436213827192;9736.75658108553;9755.170810481046;9763.85354219673;9798.804023919482;2792.2042217967783;2804.2008027712004;2836.4043550854553;2880.7983441158917;2999.355138645158;943.7593413679468;970.4759429907912;975.351391324761;981.3768257156756;985.1281615769952;19365.4190374289;19681.40955771329;19951.700724489143;20246.79753202449;20349;1025.1183981775666;1041.9635312764017;1048.3552615141784;1050.726811029138;1052.7894421115807;10831.783364332827;10918.126549875991;11045.171612129123;11135.331880087058;11186.44067796607;472089;473393;474998;487630;494132;112602.05892793713;113538.43230783958;117970;119825.40087299507;120113.39943300403;1181.4033912873945;1209.3409092044856;1234.2409418207737;1234.7839128152536;1237.2390979547513;17614.735778963583;17637.559061023065;17738.556536086184;17901.552461188574;17926.820731793036;55331.72334138303;56841.43158568361;57114;57117.42882571287;58379.70810145922;65664;65835.67082164559;67921;69096;69850.65074674595;14472.782908256175;14570.562883113524;14672.193029383487;14710.338034788247;14714;22770.089196431956;23084.538309234056;23086.422839428476;23091.307260782203;23158;18017.549561261072;18216.908915455868;18469.72295415597;18485.63028739391;18515.444536663923;16655.41706040283;17479;17902.731459028386;18221.088945552936;18345.082745862386;17827.197776100365;18046.458606241835;18074.644401669666;18151.81848181501;18170.72804903644;15037.548873533811;15240.237988100329;15279.541613751606;15294.694106118039;15296.541103766906;19110.235590576776;19154.329598463988;19211.807881921002;19254.903725481283;19276.518087047934 04:13:08 INFO - PID 8591 | |3;mootools.html;1391.3947432866703;1422.8150340455738;1452.4625888421283;1457.351478592027;1465.2380762003752;13993.090449120813;14640.121592704418;14642.487512937048;14649.633759156013;14857.405703771863;15009.249537523136;15240.085594864317;15310.617234569114;15323.233838308068;15336.923315383436;2676.7858571314296;2728.7134850840675;2729.5359788835945;2732.8496932668695;2738.315421144714;2615.542280100984;2789.507613426817;2790.079273839638;2795.175423250146;2795.8182718123358;2648.735126487355;2655.49545586338;2667.0931883159724;2685.0333879803256;2685.4629074185145;2596.286021344136;2609.4911492259016;2621.449495605925;2671.9732802672015;2686.811923165379;2552.4129450226364;2562.513122506736;2571.7685408313155;2575;2595.688517377927;13750;14228.217448040354;14401.423943042266;14416.927915360357;14437.783433248509;7688.923110768933;7987.96006019972;8003.319717823992;8007.159248278964;8010.5594192319395;5123.2059030849905;5285.920711189336;5363.275957745694;5367.409584945653;5382.2464854920345;1727.4213138598584;1794.1477798045955;1809.0592891696244;1838.3565751986832;1845.4094689699302;24005.639915401283;24019.759802402103;24100.75899241003;24180.395490112536;24206.878965605236;6464.159659244362;6504.5121615879;6524.086627872101;6668.833279167962;6701.195856497252;16432.83567164313;16483.505494835175;16502.669946601;16524.586885327724;16528.586785330463;7335.266473352622;7551.207123251979;7552.093748750185;7555.848883022419;7557.168711441737;6888.690008949609;6977.51157418986;7056.54132481387;7209.0988626421695;7214.206437291894;4986.426560945465;5098.97450512745;5124.180131178993;5129.281900533928;5164.767585458663;1497.3262032085604;1499.0555949751588;1500.1224283793886;1518.058803541789;1518.187769543289;915.9908400916039;919.4529255093208;930.5951910918772;936.5551363102472;939.0187254319253;7511.737089201852;7536.811579710441;7637.274458926393;7641.503302285334;7765.107012693499;723.3562129704567;727.7271023366237;733.0982891044046;736.7235243098851;743.8103283662631;4607.102699583067;4666.883327916829;4714.622830173578;4742.810287588527;4763.261694437368;19420.80579194218;19673;19948;20107.99460026993;20410.18359265613;19194;20059.59880802376;20333.18667253323;20391;20421.795782042285;10785.083267922315;10933.781324373467;11144.387058711849;11193.16051296156;11206.383648899226;8089.110197878346;8123.959380203061;8252.133525979925;8275.83448331042;8331.50010999342;16817.41139060127;17152.571185720455;17388.391406300718;17590.560235994202;17607.29570817153;17472.213750381008;17723.11384430799;18020.369287075413;18163.27346906109;18353.449396518125;10711.08955738771;10815.242932994615;10823.404712740874;10846.13230941507;10868;13120;13498.52755153565;13580.388882500114;13598.660033499242;13606.455741770218;10386.844197336895;10543.367397956146;10601.41692206936;10670.519826607977;10909.781804364027;10552.366857988545;10579.36523808574;10738.838917416402;10791.1367090631;10907.890921090688;9447.149756521945;9508.857367139637;9532.428054316762;9655;9657.034296570288;7226.349628533457;7246.094238220223;7259.092613423322;7302;7422.777316680508;7427.25727427253;7428.517146385468;7489.887651685338;7491.70033198666;7500.512466689648 04:13:08 INFO - PID 8591 | |4;prototype.html;502.5527280720157;514.5009340939289;518.9532942035218;527.759869259487;530.5437323901444;6231.781887633933;6243.469305109065;6283.523372007575;6286.905696414552;6297.040391016227;6132.570720049598;6159.414855588712;6167.229096362955;6189.504839612831;6198.78304259351;4772.2841573764035;5106.489351064901;5107.616928730342;5120.283160357553;5125.103106956286;4880.8047678092835;4925.975370123145;4954.479779623124;4975.9004819903585;4978.2532620107095;4895.8005288704135;4907.4356449008465;4928.581070609002;4938.135826230413;4957.603391728653;4892.3884514435695;4908.576512811316;4939.58013568847;4957.727324997124;4965.404151501825;4393.143337049277;4408.4709834819705;4440.935754329503;4471.262241730111;4471.3293006049025;6049.243844519435;6066.484348830355;6077.1491991121275;6109.755609775648;6135.386461353829;5641.717914104278;5657.462541058634;5676.063449530822;5701.828945131611;5710.600257981943;6489.415952564244;6504.544681872271;6523.543351965364;6554.967225163844;6581.177352830896;4815.879603009917;4822.782974766109;4881.658283920127;4884.804607815683;4890.290907818382;6500.414962653289;6576.539642225046;6615.173103362128;6768.492363072789;6908.205556361033;4919.87700307488;4928.654994150446;4967.677100988424;4980.327655766425;5001.249562653043;4999.400071991385;5027.321311622884;5039.949600503948;5046.495350464924;5081.949180508148;5566.499015088581;5627.212190293362;5627.662340259598;5649.293838270216;5661.46216109469;6565.24499682533;6566.343365663395;6577.375149360803;6581.873610035195;6632.005199220155;1754.1317048061292;1761.806201317854;1765.4703588923528;1770.3007312111902;1778.8665850061038;1171.701216189866;1195.940202989847;1221.8900298972958;1225.9141860069888;1232.4392401457314;5677.098172112306;5744.897755212139;5748.367679555246;5780.132980052942;5799.39106393831;6653.168353955755;6686.899696504556;6700.822232774368;6738.797836064828;6783.423409010191;5677.432256774289;5734.569907256972;5765.88468230633;5773.826785196451;5791.507721843606;3489.965100349015;3539.982300088483;3549.1836877518317;3567.2865426914723;3585.31878943;6467.902981455282;6501.772437964649;6538.901916471256;6541.5093867960095;6571.080048793173;6808.829779255559;6884.208316043619;6885.311468853075;6912.205096413876;6949.617771022541;6455.709493072823;6477.0608261800835;6482.416582507597;6495.415412612888;6544.116544266558;6591.373819487141;6591.439727623014;6689.765858195135;6701.229358623821;6703.832404189934;6044.063170208625;6521.934780652133;6633.170853643294;6640.50196235294;6670.433013193739;6447.258565264867;6458.192725909262;6481.4166724994975;6521.510886683613;6564.4748420127235;4859.927101093557;5004.674696144739;5281.128613778684;5345.812896548602;5410.431904650112;6404.647744373918;6463.482921366373;6627.138471998609;6732.697028633625;6775.356341147583;6378.808635740936;6438.6136831790245;6450.354964503512;6498.772542960974;6537.901931470937;6457.773977910751;6519.478441724746;6520.804375868732;6536.281009088902;6557.1147895035465;6402.743890244338;6407.430179606026;6411.198600174978;6423.614583125028;6510;6517.837054073686;6530;6554.213494380705;6557.377049180321;6584.835379115369;6278.560500764903;6314.842128946813;6319.273283572448;6346.301906790157;6404.967975160094 04:13:08 INFO - PID 8591 | |5;yui.html;934.1219253901332;935.9049911603423;946.3281070439987;954.3415043619901;963.0802583532727;19057.23771049158;19985.900070499647;20039.69940450891;20042.098105585246;21717.131314747432;22031.6695249571;22675.886620566875;22681.886590567065;22791.31626051217;22807.771922280772;1011.4689787861377;1039.9532021059033;1041.6822869024945;1041.7187359412953;1042.9426381549013;969.7575606098476;1053.531178625512;1058.0107599394591;1060.9098226650744;1061.3631820907472;1120.6581992492286;1129.8135807591736;1130.2709752209819;1130.8247221680654;1131.0442675938818;1116.1740312168977;1121.6635009497159;1122.4443900269418;1122.8203487442051;1124.111951558268;820.5609998650752;822.576373167819;822.6873787960596;822.8560001999626;823.1398188892622;19803.801961980338;20608.896955515276;20810.791892081037;20811.8959405202;21251.149954001823;21556.784432155633;21718.89140554303;22080.447988800246;22150.446238843997;22175.334739957827;16796.580085497837;17119.65760684792;17140.057296848794;17265.568360790956;17283.48149555503;3593.7843729376323;3622.6739593436455;3624.311380837659;3627.075095850568;3627.2201476682376;130473;131891.34054329764;133256;134999;136589;17159.142042897805;17190.31238750436;17261.741073883903;17480.388186413413;17606.471805845846;30491.2377190572;31730.365392692016;32077.358452830813;32159.35681286361;32250.838745806122;7537.283958023979;7941.285284324438;8548.829023419497;8839.425437346552;9046.05016473274;4282.978585107055;4363.040131171138;4379.233634114017;4380.211561918822;4382;5090.694558326512;5170.1986192140275;5198.298229739013;5226.216067589816;5279.313689220377;1043.1289872956168;1052.9526171322157;1070.5824728355947;1071.8552995345528;1074.5057273654206;677.6239187251024;685.869684759894;690.5062880040695;699.6991293743637;702.4275215699189;11571.6528504145;12191.207571507824;12563.246205227715;13375.732485350432;13975.161490310615;688.9069975553336;694.2224708326706;700.5621486570893;702.5222848462992;717.5228473065353;5483.232347471358;5877.529797616266;5881.470667639933;5902.468777810018;5987.042073268343;110529.44735276433;110847;111315.44342278237;112561;113431.43284283526;99322;102568.48715756374;103127.86297550319;104134.47932760288;105357.47321263344;88668.55665721631;89090.10909890948;89105;90223;92939;11636.36000020007;12073.744665576713;12637.620871373874;12641.557545486232;12665.683357916127;39495;40446.38214471506;41104.58895411008;41282.38076428796;42087.15825683408;71953;72367;74456.62771686107;74700.62649686934;75332.24667753253;17847.821521785136;18053.368132115313;18126.5468363292;18224.817751822844;18503.81496185021;19214.8078519213;19396.709049363988;20766.584668306852;21414.464638384165;21761;18858.905705471385;19063.904680477062;19116.522086947938;19522.21911123596;19568.412947611596;18484.260629574666;18806.435806925812;19287.614247715246;19296.61406771885;20034.499137521096;17600.207990640196;17650.293988240326;18016.2793488259;18233;18238.08809559543;12221.633350999484;12842.293673848028;13142;13184.60446186616;13500.324983750577;12284.1401101922;13438;13455.192688438725;13541.932290338485;14089.295535223402 04:13:08 INFO - PID 8591 | __end_tp_report 04:13:08 INFO - PID 8591 | __start_cc_report 04:13:08 INFO - PID 8591 | _x_x_mozilla_cycle_collect,383 04:13:08 INFO - PID 8591 | __end_cc_report 04:13:08 INFO - PID 8591 | __startTimestamp1503400388074__endTimestamp 04:13:08 INFO - PID 8591 | 04:13:08 INFO - PID 8591 | ------- Summary: start ------- 04:13:08 INFO - PID 8591 | Number of tests: 6 04:13:08 INFO - PID 8591 | 04:13:08 INFO - PID 8591 | [#0] dojo.html Cycles:165 Average:6158.33 Median:6426.74 stddev:725.56 (11.3%) stddev-sans-first:686.90 04:13:08 INFO - PID 8591 | Values: 3097.0 3118.3 3133.3 3133.4 3160.0 6108.4 6199.4 6223.6 6246.4 6336.8 6253.1 6277.0 6337.9 6340.4 6376.9 5646.9 5674.0 5693.2 5783.8 5812.9 5587.9 5642.6 5702.6 5770.1 5785.9 5622.5 5706.0 5724.3 5732.8 5738.5 5648.0 5656.3 5753.8 5765.7 5771.8 5644.5 5646.4 5681.6 5716.5 5730.4 6132.0 6147.2 6157.0 6161.4 6234.4 6645.1 6667.5 6739.6 6756.2 6770.0 6657.2 6701.0 6718.0 6817.3 6826.9 6181.6 6246.7 6250.1 6261.2 6265.2 6725.8 6824.0 6832.1 6901.0 6912.0 6484.3 6510.7 6519.0 6531.3 6537.8 6598.8 6603.3 6603.7 6606.6 6608.3 6443.6 6629.6 6663.9 6669.7 6674.2 6654.1 6659.4 6743.7 6749.5 6763.3 5428.2 5440.7 5491.0 5504.9 5516.6 4579.5 4643.1 4660.2 4672.8 4719.1 5843.6 5846.2 5851.9 5854.6 5862.6 6659.1 6674.0 6764.8 6774.1 6780.2 5734.6 5735.3 5807.2 5807.4 5822.2 5826.2 5886.1 5946.0 5947.7 5960.1 6502.7 6514.3 6516.2 6542.4 6545.5 6609.7 6723.7 6773.5 6780.7 6787.7 6440.3 6447.0 6481.7 6516.5 6541.1 6557.8 6562.9 6570.0 6574.9 6581.1 6701.1 6705.7 6780.0 6801.4 6810.9 6442.7 6448.8 6472.5 6551.9 6557.2 6361.7 6470.6 6492.3 6516.8 6539.9 6508.2 6517.9 6521.6 6525.7 6529.6 6394.6 6426.7 6510.2 6624.4 6656.9 6361.8 6369.9 6370.9 6384.9 6392.2 04:13:08 INFO - PID 8591 | 04:13:08 INFO - PID 8591 | [#1] ext.html Cycles:180 Average:38173.49 Median:35981.96 stddev:52576.18 (146.1%) stddev-sans-first:52648.48 04:13:08 INFO - PID 8591 | Values: 729.3 796.5 827.4 1166.1 1186.2 32065.7 32765.2 32789.7 42708.1 43672.0 43898.3 44305.3 44358.3 44397.0 44401.6 7369.5 7617.6 7909.4 7910.6 7912.7 7736.2 7788.9 7791.2 7843.2 7844.3 7793.4 7846.8 7853.8 7857.8 7862.0 7791.8 7820.8 7823.2 7824.1 7847.0 7687.7 7739.9 7743.8 7744.8 7746.9 40085.8 40096.4 40122.8 40131.8 40269.0 3493.4 3495.1 3526.8 3530.6 3537.0 32006.7 32234.5 32303.2 32427.2 32469.5 4986.4 5134.5 5151.1 5169.6 5172.0 199938.0 200169.0 201102.0 201429.0 201548.0 50118.5 50189.5 50201.0 50281.7 50283.7 52253.7 52362.5 52402.7 52458.5 52481.7 14673.4 16002.5 16446.6 16447.0 16455.2 12310.3 13245.9 13562.9 13588.6 13613.2 14814.7 14821.8 14842.3 14882.2 14896.3 5831.8 5879.6 5967.3 6003.1 6004.8 980.8 996.5 998.0 1012.7 1023.4 23179.4 23326.3 23384.3 23430.0 23814.8 1085.2 1086.8 1088.2 1096.4 1104.0 12231.3 12314.8 12424.5 12491.6 12525.3 216193.0 216711.0 218018.0 218064.0 218956.0 55283.7 55655.0 55791.0 55867.4 55997.2 1438.0 1460.7 1487.9 1488.6 1491.2 22733.4 22794.4 23011.3 23078.3 23318.7 38096.2 38196.6 38236.4 38275.2 38328.4 189158.0 189195.0 189548.0 190340.0 190924.0 34415.8 36811.4 37403.8 37621.0 37759.2 47949.5 49531.5 49853.8 49903.8 50115.0 34991.1 35587.8 35880.3 36083.6 36186.6 34456.5 35097.5 35113.0 35316.6 35424.0 38244.4 38493.0 38568.2 38932.4 39018.2 33674.8 33785.3 34224.1 34556.3 35641.5 24382.1 24396.4 24846.8 25287.9 25316.4 04:13:08 INFO - PID 8591 | 04:13:08 INFO - PID 8591 | [#2] jquery.html Cycles:180 Average:34851.82 Median:23124.65 stddev:81368.36 (351.9%) stddev-sans-first:81555.90 04:13:08 INFO - PID 8591 | Values: 566.1 569.2 573.8 575.0 592.7 22054.1 22516.1 23303.3 23310.3 23339.0 25865.5 26519.5 26538.6 26546.6 26611.0 6271.2 6390.2 6392.6 6396.6 6404.4 6061.9 6467.3 6521.4 6584.9 6651.6 6593.9 6597.1 6597.8 6602.8 6605.3 6566.9 6573.8 6583.2 6597.2 6598.6 6116.7 6148.4 6154.3 6157.2 6162.7 29447.9 30544.4 30630.0 30876.0 30953.5 1992.4 2025.3 2025.4 2027.1 2027.2 19602.7 20163.3 20169.0 20172.9 20177.8 2437.7 2441.0 2450.4 2477.6 2522.1 142085.0 143861.3 147617.0 148218.3 148268.0 14855.3 14878.0 15235.2 15465.8 15835.2 23367.3 23842.5 24157.6 24160.9 24198.3 10207.2 10214.6 10302.3 10306.9 10487.4 9398.3 9405.3 9416.0 9551.4 9575.3 9396.4 9736.8 9755.2 9763.9 9798.8 2792.2 2804.2 2836.4 2880.8 2999.4 943.8 970.5 975.4 981.4 985.1 19365.4 19681.4 19951.7 20246.8 20349.0 1025.1 1042.0 1048.4 1050.7 1052.8 10831.8 10918.1 11045.2 11135.3 11186.4 472089.0 473393.0 474998.0 487630.0 494132.0 112602.1 113538.4 117970.0 119825.4 120113.4 1181.4 1209.3 1234.2 1234.8 1237.2 17614.7 17637.6 17738.6 17901.6 17926.8 55331.7 56841.4 57114.0 57117.4 58379.7 65664.0 65835.7 67921.0 69096.0 69850.7 14472.8 14570.6 14672.2 14710.3 14714.0 22770.1 23084.5 23086.4 23091.3 23158.0 18017.5 18216.9 18469.7 18485.6 18515.4 16655.4 17479.0 17902.7 18221.1 18345.1 17827.2 18046.5 18074.6 18151.8 18170.7 15037.5 15240.2 15279.5 15294.7 15296.5 19110.2 19154.3 19211.8 19254.9 19276.5 04:13:08 INFO - PID 8591 | 04:13:08 INFO - PID 8591 | [#3] mootools.html Cycles:180 Average:8908.01 Median:2602.89 stddev:6194.51 (238.0%) stddev-sans-first:6186.14 04:13:08 INFO - PID 8591 | Values: 1391.4 1422.8 1452.5 1457.4 1465.2 13993.1 14640.1 14642.5 14649.6 14857.4 15009.2 15240.1 15310.6 15323.2 15336.9 2676.8 2728.7 2729.5 2732.8 2738.3 2615.5 2789.5 2790.1 2795.2 2795.8 2648.7 2655.5 2667.1 2685.0 2685.5 2596.3 2609.5 2621.4 2672.0 2686.8 2552.4 2562.5 2571.8 2575.0 2595.7 13750.0 14228.2 14401.4 14416.9 14437.8 7688.9 7988.0 8003.3 8007.2 8010.6 5123.2 5285.9 5363.3 5367.4 5382.2 1727.4 1794.1 1809.1 1838.4 1845.4 24005.6 24019.8 24100.8 24180.4 24206.9 6464.2 6504.5 6524.1 6668.8 6701.2 16432.8 16483.5 16502.7 16524.6 16528.6 7335.3 7551.2 7552.1 7555.8 7557.2 6888.7 6977.5 7056.5 7209.1 7214.2 4986.4 5099.0 5124.2 5129.3 5164.8 1497.3 1499.1 1500.1 1518.1 1518.2 916.0 919.5 930.6 936.6 939.0 7511.7 7536.8 7637.3 7641.5 7765.1 723.4 727.7 733.1 736.7 743.8 4607.1 4666.9 4714.6 4742.8 4763.3 19420.8 19673.0 19948.0 20108.0 20410.2 19194.0 20059.6 20333.2 20391.0 20421.8 10785.1 10933.8 11144.4 11193.2 11206.4 8089.1 8124.0 8252.1 8275.8 8331.5 16817.4 17152.6 17388.4 17590.6 17607.3 17472.2 17723.1 18020.4 18163.3 18353.4 10711.1 10815.2 10823.4 10846.1 10868.0 13120.0 13498.5 13580.4 13598.7 13606.5 10386.8 10543.4 10601.4 10670.5 10909.8 10552.4 10579.4 10738.8 10791.1 10907.9 9447.1 9508.9 9532.4 9655.0 9657.0 7226.3 7246.1 7259.1 7302.0 7422.8 7427.3 7428.5 7489.9 7491.7 7500.5 04:13:08 INFO - PID 8591 | 04:13:08 INFO - PID 8591 | [#4] prototype.html Cycles:180 Average:5490.04 Median:6133.98 stddev:1534.04 (25.0%) stddev-sans-first:1491.97 04:13:08 INFO - PID 8591 | Values: 502.6 514.5 519.0 527.8 530.5 6231.8 6243.5 6283.5 6286.9 6297.0 6132.6 6159.4 6167.2 6189.5 6198.8 4772.3 5106.5 5107.6 5120.3 5125.1 4880.8 4926.0 4954.5 4975.9 4978.3 4895.8 4907.4 4928.6 4938.1 4957.6 4892.4 4908.6 4939.6 4957.7 4965.4 4393.1 4408.5 4440.9 4471.3 4471.3 6049.2 6066.5 6077.1 6109.8 6135.4 5641.7 5657.5 5676.1 5701.8 5710.6 6489.4 6504.5 6523.5 6555.0 6581.2 4815.9 4822.8 4881.7 4884.8 4890.3 6500.4 6576.5 6615.2 6768.5 6908.2 4919.9 4928.7 4967.7 4980.3 5001.2 4999.4 5027.3 5039.9 5046.5 5081.9 5566.5 5627.2 5627.7 5649.3 5661.5 6565.2 6566.3 6577.4 6581.9 6632.0 1754.1 1761.8 1765.5 1770.3 1778.9 1171.7 1195.9 1221.9 1225.9 1232.4 5677.1 5744.9 5748.4 5780.1 5799.4 6653.2 6686.9 6700.8 6738.8 6783.4 5677.4 5734.6 5765.9 5773.8 5791.5 3490.0 3540.0 3549.2 3567.3 3585.3 6467.9 6501.8 6538.9 6541.5 6571.1 6808.8 6884.2 6885.3 6912.2 6949.6 6455.7 6477.1 6482.4 6495.4 6544.1 6591.4 6591.4 6689.8 6701.2 6703.8 6044.1 6521.9 6633.2 6640.5 6670.4 6447.3 6458.2 6481.4 6521.5 6564.5 4859.9 5004.7 5281.1 5345.8 5410.4 6404.6 6463.5 6627.1 6732.7 6775.4 6378.8 6438.6 6450.4 6498.8 6537.9 6457.8 6519.5 6520.8 6536.3 6557.1 6402.7 6407.4 6411.2 6423.6 6510.0 6517.8 6530.0 6554.2 6557.4 6584.8 6278.6 6314.8 6319.3 6346.3 6405.0 04:13:08 INFO - PID 8591 | 04:13:08 INFO - PID 8591 | [#5] yui.html Cycles:180 Average:24629.03 Median:19894.85 stddev:33570.53 (168.7%) stddev-sans-first:33617.56 04:13:08 INFO - PID 8591 | Values: 934.1 935.9 946.3 954.3 963.1 19057.2 19985.9 20039.7 20042.1 21717.1 22031.7 22675.9 22681.9 22791.3 22807.8 1011.5 1040.0 1041.7 1041.7 1042.9 969.8 1053.5 1058.0 1060.9 1061.4 1120.7 1129.8 1130.3 1130.8 1131.0 1116.2 1121.7 1122.4 1122.8 1124.1 820.6 822.6 822.7 822.9 823.1 19803.8 20608.9 20810.8 20811.9 21251.1 21556.8 21718.9 22080.4 22150.4 22175.3 16796.6 17119.7 17140.1 17265.6 17283.5 3593.8 3622.7 3624.3 3627.1 3627.2 130473.0 131891.3 133256.0 134999.0 136589.0 17159.1 17190.3 17261.7 17480.4 17606.5 30491.2 31730.4 32077.4 32159.4 32250.8 7537.3 7941.3 8548.8 8839.4 9046.1 4283.0 4363.0 4379.2 4380.2 4382.0 5090.7 5170.2 5198.3 5226.2 5279.3 1043.1 1053.0 1070.6 1071.9 1074.5 677.6 685.9 690.5 699.7 702.4 11571.7 12191.2 12563.2 13375.7 13975.2 688.9 694.2 700.6 702.5 717.5 5483.2 5877.5 5881.5 5902.5 5987.0 110529.4 110847.0 111315.4 112561.0 113431.4 99322.0 102568.5 103127.9 104134.5 105357.5 88668.6 89090.1 89105.0 90223.0 92939.0 11636.4 12073.7 12637.6 12641.6 12665.7 39495.0 40446.4 41104.6 41282.4 42087.2 71953.0 72367.0 74456.6 74700.6 75332.2 17847.8 18053.4 18126.5 18224.8 18503.8 19214.8 19396.7 20766.6 21414.5 21761.0 18858.9 19063.9 19116.5 19522.2 19568.4 18484.3 18806.4 19287.6 19296.6 20034.5 17600.2 17650.3 18016.3 18233.0 18238.1 12221.6 12842.3 13142.0 13184.6 13500.3 12284.1 13438.0 13455.2 13541.9 14089.3 04:13:08 INFO - PID 8591 | -------- Summary: end -------- 04:13:08 INFO - PID 8591 | 04:13:08 INFO - TEST-INFO | 8591: exit 0 04:13:08 INFO - TEST-OK | dromaeo_css | took 1110890ms 04:13:08 INFO - TEST-START | kraken 04:13:08 INFO - Initialising browser for kraken test... 04:13:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33926/getInfo.html -profile /tmp/tmpzuyQMK/profile 04:13:08 INFO - TEST-INFO | started process 8998 (/builds/slave/test/build/application/firefox/firefox http://localhost:33926/getInfo.html) 04:13:14 INFO - TEST-INFO | 8998: exit 0 04:13:14 INFO - Browser initialized. 04:13:14 INFO - Running cycle 1/1 for kraken test... 04:13:14 INFO - TEST-INFO | started process 9210 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzuyQMK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:15 INFO - PID 9210 | 04:13:15 INFO - PID 9210 | (/builds/slave/test/build/application/firefox/firefox:9261): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:13:15 INFO - PID 9210 | 04:13:15 INFO - PID 9210 | 04:13:15 INFO - PID 9210 | (/builds/slave/test/build/application/firefox/firefox:9313): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:13:15 INFO - PID 9210 | 04:13:16 INFO - PID 9210 | __metrics Screen width/height:1600/1200 04:13:16 INFO - PID 9210 | colorDepth:24 04:13:16 INFO - PID 9210 | Browser inner width/height: 1024/768 04:13:16 INFO - PID 9210 | __metrics 04:13:25 INFO - PID 9210 | RSS: Main: 172244992 04:13:25 INFO - PID 9210 | 04:13:28 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33926/tests/kraken/driver.html?testName=audio-beat-detection) 04:13:29 INFO - PID 9210 | RSS: Main: 175742976 04:13:29 INFO - PID 9210 | 04:13:31 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33926/tests/kraken/driver.html?testName=audio-dft) 04:13:32 INFO - PID 9210 | RSS: Main: 177270784 04:13:32 INFO - PID 9210 | 04:13:35 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33926/tests/kraken/driver.html?testName=audio-fft) 04:13:36 INFO - PID 9210 | RSS: Main: 170614784 04:13:36 INFO - PID 9210 | 04:13:38 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33926/tests/kraken/driver.html?testName=audio-oscillator) 04:13:38 INFO - PID 9210 | RSS: Main: 171360256 04:13:38 INFO - PID 9210 | 04:13:41 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33926/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:13:41 INFO - PID 9210 | RSS: Main: 171732992 04:13:41 INFO - PID 9210 | 04:13:44 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33926/tests/kraken/driver.html?testName=imaging-darkroom) 04:13:45 INFO - PID 9210 | RSS: Main: 173027328 04:13:45 INFO - PID 9210 | 04:13:48 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33926/tests/kraken/driver.html?testName=imaging-desaturate) 04:13:49 INFO - PID 9210 | RSS: Main: 173686784 04:13:49 INFO - PID 9210 | 04:13:52 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33926/tests/kraken/driver.html?testName=json-parse-financial) 04:13:52 INFO - PID 9210 | RSS: Main: 173068288 04:13:52 INFO - PID 9210 | 04:13:54 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33926/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:13:55 INFO - PID 9210 | RSS: Main: 173838336 04:13:55 INFO - PID 9210 | 04:13:56 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33926/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:13:57 INFO - PID 9210 | RSS: Main: 173477888 04:13:57 INFO - PID 9210 | 04:13:59 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33926/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:14:00 INFO - PID 9210 | RSS: Main: 173453312 04:14:00 INFO - PID 9210 | 04:14:02 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:14:03 INFO - PID 9210 | RSS: Main: 173363200 04:14:03 INFO - PID 9210 | 04:14:06 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:14:07 INFO - PID 9210 | RSS: Main: 173305856 04:14:07 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | Cycle 1(1): loaded http://localhost:33926/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33926/tests/kraken/driver.html?testName=ai-astar) 04:14:09 INFO - PID 9210 | RSS: Main: 174559232 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | __start_tp_report 04:14:09 INFO - PID 9210 | _x_x_mozilla_page_load 04:14:09 INFO - PID 9210 | _x_x_mozilla_page_load_details 04:14:09 INFO - PID 9210 | |i|pagename|runs| 04:14:09 INFO - PID 9210 | |0;ai-astar;101;109;95;107;108;108;111;109;109;110 04:14:09 INFO - PID 9210 | |1;audio-beat-detection;142;122;143;166;121;149;150;117;175;120 04:14:09 INFO - PID 9210 | |2;audio-dft;165;165;164;163;164;164;162;170;164;164 04:14:09 INFO - PID 9210 | |3;audio-fft;78;77;76;167;76;76;75;75;158;76 04:14:09 INFO - PID 9210 | |4;audio-oscillator;79;79;128;80;81;80;126;79;80;129 04:14:09 INFO - PID 9210 | |5;imaging-gaussian-blur;114;114;115;115;114;115;116;114;114;114 04:14:09 INFO - PID 9210 | |6;imaging-darkroom;151;150;152;150;153;150;150;151;152;149 04:14:09 INFO - PID 9210 | |7;imaging-desaturate;94;94;95;94;93;93;94;95;94;94 04:14:09 INFO - PID 9210 | |8;json-parse-financial;54;55;54;54;54;55;57;54;54;54 04:14:09 INFO - PID 9210 | |9;json-stringify-tinderbox;55;54;56;55;55;55;56;54;55;55 04:14:09 INFO - PID 9210 | |10;stanford-crypto-aes;77;82;77;76;75;76;77;79;76;78 04:14:09 INFO - PID 9210 | |11;stanford-crypto-ccm;132;123;123;129;124;134;120;123;125;178 04:14:09 INFO - PID 9210 | |12;stanford-crypto-pbkdf2;195;177;180;183;182;174;181;171;172;190 04:14:09 INFO - PID 9210 | |13;stanford-crypto-sha256-iterative;70;73;68;69;68;69;67;67;71;66 04:14:09 INFO - PID 9210 | __end_tp_report 04:14:09 INFO - PID 9210 | __start_cc_report 04:14:09 INFO - PID 9210 | _x_x_mozilla_cycle_collect,984 04:14:09 INFO - PID 9210 | __end_cc_report 04:14:09 INFO - PID 9210 | __startTimestamp1503400449484__endTimestamp 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | ------- Summary: start ------- 04:14:09 INFO - PID 9210 | Number of tests: 14 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#0] ai-astar Cycles:10 Average:106.70 Median:109.00 stddev:4.92 (4.5%) stddev-sans-first:4.77 04:14:09 INFO - PID 9210 | Values: 101.0 109.0 95.0 107.0 108.0 108.0 111.0 109.0 109.0 110.0 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:146.00 stddev:20.29 (13.9%) stddev-sans-first:21.52 04:14:09 INFO - PID 9210 | Values: 142.0 122.0 143.0 166.0 121.0 149.0 150.0 117.0 175.0 120.0 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.12 (1.3%) stddev-sans-first:2.24 04:14:09 INFO - PID 9210 | Values: 165.0 165.0 164.0 163.0 164.0 164.0 162.0 170.0 164.0 164.0 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:36.49 (48.0%) stddev-sans-first:38.28 04:14:09 INFO - PID 9210 | Values: 78.0 77.0 76.0 167.0 76.0 76.0 75.0 75.0 158.0 76.0 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:79.50 stddev:23.18 (29.2%) stddev-sans-first:23.94 04:14:09 INFO - PID 9210 | Values: 79.0 79.0 128.0 80.0 81.0 80.0 126.0 79.0 80.0 129.0 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 04:14:09 INFO - PID 9210 | Values: 114.0 114.0 115.0 115.0 114.0 115.0 116.0 114.0 114.0 114.0 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 04:14:09 INFO - PID 9210 | Values: 151.0 150.0 152.0 150.0 153.0 150.0 150.0 151.0 152.0 149.0 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:14:09 INFO - PID 9210 | Values: 94.0 94.0 95.0 94.0 93.0 93.0 94.0 95.0 94.0 94.0 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 04:14:09 INFO - PID 9210 | Values: 54.0 55.0 54.0 54.0 54.0 55.0 57.0 54.0 54.0 54.0 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 04:14:09 INFO - PID 9210 | Values: 55.0 54.0 56.0 55.0 55.0 55.0 56.0 54.0 55.0 55.0 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:77.00 stddev:2.00 (2.6%) stddev-sans-first:2.12 04:14:09 INFO - PID 9210 | Values: 77.0 82.0 77.0 76.0 75.0 76.0 77.0 79.0 76.0 78.0 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:127.00 stddev:17.06 (13.4%) stddev-sans-first:18.10 04:14:09 INFO - PID 9210 | Values: 132.0 123.0 123.0 129.0 124.0 134.0 120.0 123.0 125.0 178.0 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.50 Median:181.50 stddev:7.65 (4.2%) stddev-sans-first:6.05 04:14:09 INFO - PID 9210 | Values: 195.0 177.0 180.0 183.0 182.0 174.0 181.0 171.0 172.0 190.0 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:2.10 (3.0%) stddev-sans-first:2.18 04:14:09 INFO - PID 9210 | Values: 70.0 73.0 68.0 69.0 68.0 69.0 67.0 67.0 71.0 66.0 04:14:09 INFO - PID 9210 | -------- Summary: end -------- 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | 04:14:09 INFO - PID 9210 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 04:14:09 INFO - PID 9210 | 04:14:10 INFO - PID 9210 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:14:10 INFO - TEST-INFO | 9210: exit 0 04:14:10 INFO - TEST-OK | kraken | took 61668ms 04:14:10 INFO - SUITE-END | took 1172s 04:14:10 INFO - Completed test suite (00:19:32) 04:14:10 INFO - javascript benchmark 04:14:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8576.315393848845, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.0399176255364, 3118.2827949571597, 3133.32633483801, 3133.3733253349337, 3159.968400315996, 6108.4197001284865, 6199.44205021548, 6223.595466294688, 6246.437820596146, 6336.778212762554, 6253.093301471284, 6277.0, 6337.936620633793, 6340.3976622220935, 6376.9362306376925, 5646.858828529279, 5673.978683836907, 5693.174489698991, 5783.797567085153, 5812.854678633047, 5587.944120558804, 5642.633228840113, 5702.572307076965, 5770.134479828017, 5785.884282314372, 5622.4939755422, 5705.971470142665, 5724.341700704431, 5732.770689172428, 5738.512226460735, 5648.0, 5656.264685590888, 5753.769849206027, 5765.740541675593, 5771.769129234825, 5644.520215781622, 5646.350669672999, 5681.630694004876, 5716.542676585905, 5730.398308177623, 6132.049532322497, 6147.2008638877105, 6157.0, 6161.44546990773, 6234.438900498977, 6645.102911106987, 6667.533272670915, 6739.6293203873765, 6756.223034351064, 6769.966150169267, 6657.201135863679, 6700.966495167541, 6717.966410167966, 6817.284185160586, 6826.897596536056, 6181.598196117238, 6246.656433896134, 6250.124982502453, 6261.248650161964, 6265.154204182422, 6725.764598239136, 6823.965880170567, 6832.111825462658, 6901.0, 6912.0, 6484.286728459866, 6510.674466276667, 6519.0, 6531.314212007671, 6537.836554086186, 6598.769043083469, 6603.273639899608, 6603.7358505660195, 6606.6036037837885, 6608.2730899601, 6443.581167224115, 6629.635370054597, 6663.900041499382, 6669.666516674244, 6674.232463266787, 6654.101696271038, 6659.367360100783, 6743.662816859138, 6749.527533072736, 6763.256041835394, 5428.240046393508, 5440.700761458158, 5490.972545137249, 5504.889902201933, 5516.641418307797, 4579.450465944108, 4643.141018911445, 4660.231061874821, 4672.789724462407, 4719.1033703596895, 5843.5909486336395, 5846.239988801429, 5851.941480585139, 5854.648721076749, 5862.560307976919, 6659.134312539339, 6674.0, 6764.763233286812, 6774.051632771318, 6780.1524809398825, 5734.598578099493, 5735.254416925856, 5807.157962095473, 5807.419258074159, 5822.243108395882, 5826.213461182686, 5886.058230683156, 5945.970270148621, 5947.672877991666, 5960.105984102419, 6502.739890404331, 6514.283428822826, 6516.152900122954, 6542.411182993554, 6545.5090868184125, 6609.702563384755, 6723.7310507581105, 6773.491988100814, 6780.72877084911, 6787.660616969033, 6440.25937017249, 6447.0, 6481.675916204265, 6516.478681705357, 6541.08424820516, 6557.836054098495, 6562.934370656232, 6569.967150164219, 6574.868502629825, 6581.14445122131, 6701.0953521274005, 6705.698243579148, 6780.0, 6801.421879140328, 6810.897836532555, 6442.742290308335, 6448.806535803933, 6472.5145614080075, 6551.918933376131, 6557.180352455943, 6361.650109244036, 6470.579412338371, 6492.253390860112, 6516.771912983023, 6539.901901471577, 6508.186476690414, 6517.9348206517325, 6521.608703477807, 6525.706343214471, 6529.640869752209, 6394.584352017104, 6426.742930282736, 6510.218773746991, 6624.403803657694, 6656.866862662817, 6361.777337793155, 6369.936300636934, 6370.936290637034, 6384.936150638434, 6392.20097487814], "value": 6103.468137700077, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.3180875881052, 796.5220867479513, 827.3670641958903, 1166.1079274355116, 1186.2170967161676, 32065.67934320656, 32765.18087047825, 32789.67210327899, 42708.14583708324, 43672.0, 43898.34152487715, 44305.335419968644, 44358.33462498057, 44397.0, 44401.55598444014, 7369.520981136236, 7617.619119044053, 7909.446338756289, 7910.644021019039, 7912.683492660315, 7736.226377362275, 7788.922110778876, 7791.181925897784, 7843.21567843214, 7844.333231675315, 7793.376529877624, 7846.843063138734, 7853.764387068397, 7857.8035549111155, 7862.0, 7791.844163116734, 7820.804479887991, 7823.2176782321885, 7824.1002284737415, 7847.0, 7687.654055567513, 7739.883901741478, 7743.8451230975625, 7744.7676569703, 7746.883796743054, 40085.79957100225, 40096.39855402171, 40122.79938600288, 40131.7993410034, 40269.0, 3493.353729560014, 3495.07380544156, 3526.806025668587, 3530.5763308402898, 3536.9646303536892, 32006.6799332006, 32234.516482252784, 32303.192420189447, 32427.18932026718, 32469.51295730566, 4986.376702912136, 5134.512221339004, 5151.072806894757, 5169.586433085344, 5171.965606878602, 199938.0, 200169.0, 201102.0, 201429.0, 201548.0, 50118.49881501211, 50189.498105019215, 50201.0, 50281.74859125681, 50283.74858125686, 52253.7387313061, 52362.476375236525, 52402.73798631059, 52458.47541524536, 52481.737591312565, 14673.413063477556, 16002.519924402053, 16446.588835279214, 16447.0, 16455.177241138135, 12310.322932238634, 13245.933770331087, 13562.864371356358, 13588.59234222975, 13613.183209007491, 14814.703705925822, 14821.777673334693, 14842.332095055532, 14882.181480018486, 14896.255187240595, 5831.825045248649, 5879.559033072536, 5967.343592204854, 6003.129546215774, 6004.819855404345, 980.8283550378655, 996.5166894056376, 997.9900200997897, 1012.731626119079, 1023.4217667018111, 23179.420514487272, 23326.300210993697, 23384.298471045895, 23430.0, 23814.7618523816, 1085.1861104171871, 1086.788076325109, 1088.2382332367374, 1096.4079397125463, 1103.9613613523488, 12231.266124032587, 12314.81527777084, 12424.503019879285, 12491.625251242478, 12525.31110788897, 216193.0, 216711.0, 218018.0, 218064.0, 218956.0, 55283.72358138183, 55655.0, 55791.0, 55867.44132558704, 55997.1600425994, 1437.978430323546, 1460.70785842834, 1487.910725356482, 1488.6204017975563, 1491.2022068193464, 22733.431664207867, 22794.43013924599, 23011.309660710205, 23078.307650770505, 23318.65022024637, 38096.23807523889, 38196.61803382042, 38236.42645360266, 38275.23449531049, 38328.42507362336, 189158.0, 189195.0, 189548.0, 190340.0, 190924.0, 34415.82792086023, 36811.447828282064, 37403.81298093492, 37621.0, 37759.244815104095, 47949.5205047959, 49531.50468495269, 49853.75073124611, 49903.75048124736, 50115.0, 34991.12522186965, 35587.82206088953, 35880.282394351445, 36083.63916360803, 36186.638133618326, 34456.48315275323, 35097.47353789644, 35113.0, 35316.646833532366, 35424.0, 38244.426333605574, 38493.0, 38568.228635427695, 38932.41601376038, 39018.2196356077, 33674.83162584171, 33785.3242935135, 34224.144396389296, 34556.30887382288, 35641.46537801883, 24382.146624868044, 24396.390090247885, 24846.751532484443, 25287.87356063208, 25316.36709082214], "value": 17626.018253225535, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.1281626295505, 569.2087997683218, 573.7590212110914, 575.0224618149144, 592.6740292838939, 22054.117835286568, 22516.09935602576, 23303.300900972954, 23310.300690979257, 23338.999999999978, 25865.482690346184, 26519.469610607775, 26538.6019209712, 26546.601800973, 26611.0, 6271.247450305969, 6390.201224846895, 6392.616443013434, 6396.61620302781, 6404.359564043605, 6061.878762424749, 6467.256265529454, 6521.380468855451, 6584.868302633944, 6651.600903945779, 6593.934060659404, 6597.142371491699, 6597.769078082268, 6602.801915942529, 6605.273419923805, 6566.8686626267445, 6573.835654108638, 6583.2429270633775, 6597.208334999783, 6598.571092878948, 6116.724747386378, 6148.446639802394, 6154.323024467305, 6157.168782214389, 6162.7226774795245, 29447.852760736274, 30544.389112217632, 30630.0, 30876.0, 30953.53569696456, 1992.392320342295, 2025.2506572568243, 2025.3923822853085, 2027.0675489274952, 2027.2499175305084, 19602.70595941062, 20163.294284699965, 20169.0, 20172.899135504376, 20177.79822201774, 2437.731849496554, 2441.0, 2450.3506570758764, 2477.5664258754646, 2522.092046863128, 142085.0, 143861.28069359585, 147617.0, 148218.25890870584, 148268.0, 14855.2572371381, 14878.0, 15235.162066086472, 15465.768013479581, 15835.208239587975, 23367.298981030595, 23842.523149537257, 24157.637635435483, 24160.87919560391, 24198.274051778473, 10207.213737595892, 10214.642487512901, 10302.33034852732, 10306.948465257776, 10487.423191724529, 9398.34211605181, 9405.294602904809, 9416.0, 9551.42691438502, 9575.318910705013, 9396.436213827192, 9736.75658108553, 9755.170810481046, 9763.85354219673, 9798.804023919482, 2792.2042217967783, 2804.2008027712004, 2836.4043550854553, 2880.7983441158917, 2999.355138645158, 943.7593413679468, 970.4759429907912, 975.351391324761, 981.3768257156756, 985.1281615769952, 19365.4190374289, 19681.40955771329, 19951.700724489143, 20246.79753202449, 20349.0, 1025.1183981775666, 1041.9635312764017, 1048.3552615141784, 1050.726811029138, 1052.7894421115807, 10831.783364332827, 10918.126549875991, 11045.171612129123, 11135.331880087058, 11186.44067796607, 472089.0, 473393.0, 474998.0, 487630.0, 494132.0, 112602.05892793713, 113538.43230783958, 117970.0, 119825.40087299507, 120113.39943300403, 1181.4033912873945, 1209.3409092044856, 1234.2409418207737, 1234.7839128152536, 1237.2390979547513, 17614.735778963583, 17637.559061023065, 17738.556536086184, 17901.552461188574, 17926.820731793036, 55331.72334138303, 56841.43158568361, 57114.0, 57117.42882571287, 58379.70810145922, 65664.0, 65835.67082164559, 67921.0, 69096.0, 69850.65074674595, 14472.782908256175, 14570.562883113524, 14672.193029383487, 14710.338034788247, 14714.0, 22770.089196431956, 23084.538309234056, 23086.422839428476, 23091.307260782203, 23158.0, 18017.549561261072, 18216.908915455868, 18469.72295415597, 18485.63028739391, 18515.444536663923, 16655.41706040283, 17479.0, 17902.731459028386, 18221.088945552936, 18345.082745862386, 17827.197776100365, 18046.458606241835, 18074.644401669666, 18151.81848181501, 18170.72804903644, 15037.548873533811, 15240.237988100329, 15279.541613751606, 15294.694106118039, 15296.541103766906, 19110.235590576776, 19154.329598463988, 19211.807881921002, 19254.903725481283, 19276.518087047934], "value": 12121.658533791893, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.3947432866703, 1422.8150340455738, 1452.4625888421283, 1457.351478592027, 1465.2380762003752, 13993.090449120813, 14640.121592704418, 14642.487512937048, 14649.633759156013, 14857.405703771863, 15009.249537523136, 15240.085594864317, 15310.617234569114, 15323.233838308068, 15336.923315383436, 2676.7858571314296, 2728.7134850840675, 2729.5359788835945, 2732.8496932668695, 2738.315421144714, 2615.542280100984, 2789.507613426817, 2790.079273839638, 2795.175423250146, 2795.8182718123358, 2648.735126487355, 2655.49545586338, 2667.0931883159724, 2685.0333879803256, 2685.4629074185145, 2596.286021344136, 2609.4911492259016, 2621.449495605925, 2671.9732802672015, 2686.811923165379, 2552.4129450226364, 2562.513122506736, 2571.7685408313155, 2575.0, 2595.688517377927, 13750.0, 14228.217448040354, 14401.423943042266, 14416.927915360357, 14437.783433248509, 7688.923110768933, 7987.96006019972, 8003.319717823992, 8007.159248278964, 8010.5594192319395, 5123.2059030849905, 5285.920711189336, 5363.275957745694, 5367.409584945653, 5382.2464854920345, 1727.4213138598584, 1794.1477798045955, 1809.0592891696244, 1838.3565751986832, 1845.4094689699302, 24005.639915401283, 24019.759802402103, 24100.75899241003, 24180.395490112536, 24206.878965605236, 6464.159659244362, 6504.5121615879, 6524.086627872101, 6668.833279167962, 6701.195856497252, 16432.83567164313, 16483.505494835175, 16502.669946601, 16524.586885327724, 16528.586785330463, 7335.266473352622, 7551.207123251979, 7552.093748750185, 7555.848883022419, 7557.168711441737, 6888.690008949609, 6977.51157418986, 7056.54132481387, 7209.0988626421695, 7214.206437291894, 4986.426560945465, 5098.97450512745, 5124.180131178993, 5129.281900533928, 5164.767585458663, 1497.3262032085604, 1499.0555949751588, 1500.1224283793886, 1518.058803541789, 1518.187769543289, 915.9908400916039, 919.4529255093208, 930.5951910918772, 936.5551363102472, 939.0187254319253, 7511.737089201852, 7536.811579710441, 7637.274458926393, 7641.503302285334, 7765.107012693499, 723.3562129704567, 727.7271023366237, 733.0982891044046, 736.7235243098851, 743.8103283662631, 4607.102699583067, 4666.883327916829, 4714.622830173578, 4742.810287588527, 4763.261694437368, 19420.80579194218, 19673.0, 19948.0, 20107.99460026993, 20410.18359265613, 19194.0, 20059.59880802376, 20333.18667253323, 20391.0, 20421.795782042285, 10785.083267922315, 10933.781324373467, 11144.387058711849, 11193.16051296156, 11206.383648899226, 8089.110197878346, 8123.959380203061, 8252.133525979925, 8275.83448331042, 8331.50010999342, 16817.41139060127, 17152.571185720455, 17388.391406300718, 17590.560235994202, 17607.29570817153, 17472.213750381008, 17723.11384430799, 18020.369287075413, 18163.27346906109, 18353.449396518125, 10711.08955738771, 10815.242932994615, 10823.404712740874, 10846.13230941507, 10868.0, 13120.0, 13498.52755153565, 13580.388882500114, 13598.660033499242, 13606.455741770218, 10386.844197336895, 10543.367397956146, 10601.41692206936, 10670.519826607977, 10909.781804364027, 10552.366857988545, 10579.36523808574, 10738.838917416402, 10791.1367090631, 10907.890921090688, 9447.149756521945, 9508.857367139637, 9532.428054316762, 9655.0, 9657.034296570288, 7226.349628533457, 7246.094238220223, 7259.092613423322, 7302.0, 7422.777316680508, 7427.25727427253, 7428.517146385468, 7489.887651685338, 7491.70033198666, 7500.512466689648], "value": 6421.609643413923, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.5527280720157, 514.5009340939289, 518.9532942035218, 527.759869259487, 530.5437323901444, 6231.781887633933, 6243.469305109065, 6283.523372007575, 6286.905696414552, 6297.040391016227, 6132.570720049598, 6159.414855588712, 6167.229096362955, 6189.504839612831, 6198.78304259351, 4772.2841573764035, 5106.489351064901, 5107.616928730342, 5120.283160357553, 5125.103106956286, 4880.8047678092835, 4925.975370123145, 4954.479779623124, 4975.9004819903585, 4978.2532620107095, 4895.8005288704135, 4907.4356449008465, 4928.581070609002, 4938.135826230413, 4957.603391728653, 4892.3884514435695, 4908.576512811316, 4939.58013568847, 4957.727324997124, 4965.404151501825, 4393.143337049277, 4408.4709834819705, 4440.935754329503, 4471.262241730111, 4471.3293006049025, 6049.243844519435, 6066.484348830355, 6077.1491991121275, 6109.755609775648, 6135.386461353829, 5641.717914104278, 5657.462541058634, 5676.063449530822, 5701.828945131611, 5710.600257981943, 6489.415952564244, 6504.544681872271, 6523.543351965364, 6554.967225163844, 6581.177352830896, 4815.879603009917, 4822.782974766109, 4881.658283920127, 4884.804607815683, 4890.290907818382, 6500.414962653289, 6576.539642225046, 6615.173103362128, 6768.492363072789, 6908.205556361033, 4919.87700307488, 4928.654994150446, 4967.677100988424, 4980.327655766425, 5001.249562653043, 4999.400071991385, 5027.321311622884, 5039.949600503948, 5046.495350464924, 5081.949180508148, 5566.499015088581, 5627.212190293362, 5627.662340259598, 5649.293838270216, 5661.46216109469, 6565.24499682533, 6566.343365663395, 6577.375149360803, 6581.873610035195, 6632.005199220155, 1754.1317048061292, 1761.806201317854, 1765.4703588923528, 1770.3007312111902, 1778.8665850061038, 1171.701216189866, 1195.940202989847, 1221.8900298972958, 1225.9141860069888, 1232.4392401457314, 5677.098172112306, 5744.897755212139, 5748.367679555246, 5780.132980052942, 5799.39106393831, 6653.168353955755, 6686.899696504556, 6700.822232774368, 6738.797836064828, 6783.423409010191, 5677.432256774289, 5734.569907256972, 5765.88468230633, 5773.826785196451, 5791.507721843606, 3489.965100349015, 3539.982300088483, 3549.1836877518317, 3567.2865426914723, 3585.31878943, 6467.902981455282, 6501.772437964649, 6538.901916471256, 6541.5093867960095, 6571.080048793173, 6808.829779255559, 6884.208316043619, 6885.311468853075, 6912.205096413876, 6949.617771022541, 6455.709493072823, 6477.0608261800835, 6482.416582507597, 6495.415412612888, 6544.116544266558, 6591.373819487141, 6591.439727623014, 6689.765858195135, 6701.229358623821, 6703.832404189934, 6044.063170208625, 6521.934780652133, 6633.170853643294, 6640.50196235294, 6670.433013193739, 6447.258565264867, 6458.192725909262, 6481.4166724994975, 6521.510886683613, 6564.4748420127235, 4859.927101093557, 5004.674696144739, 5281.128613778684, 5345.812896548602, 5410.431904650112, 6404.647744373918, 6463.482921366373, 6627.138471998609, 6732.697028633625, 6775.356341147583, 6378.808635740936, 6438.6136831790245, 6450.354964503512, 6498.772542960974, 6537.901931470937, 6457.773977910751, 6519.478441724746, 6520.804375868732, 6536.281009088902, 6557.1147895035465, 6402.743890244338, 6407.430179606026, 6411.198600174978, 6423.614583125028, 6510.0, 6517.837054073686, 6530.0, 6554.213494380705, 6557.377049180321, 6584.835379115369, 6278.560500764903, 6314.842128946813, 6319.273283572448, 6346.301906790157, 6404.967975160094], "value": 5040.044283808111, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [934.1219253901332, 935.9049911603423, 946.3281070439987, 954.3415043619901, 963.0802583532727, 19057.23771049158, 19985.900070499647, 20039.69940450891, 20042.098105585246, 21717.131314747432, 22031.6695249571, 22675.886620566875, 22681.886590567065, 22791.31626051217, 22807.771922280772, 1011.4689787861377, 1039.9532021059033, 1041.6822869024945, 1041.7187359412953, 1042.9426381549013, 969.7575606098476, 1053.531178625512, 1058.0107599394591, 1060.9098226650744, 1061.3631820907472, 1120.6581992492286, 1129.8135807591736, 1130.2709752209819, 1130.8247221680654, 1131.0442675938818, 1116.1740312168977, 1121.6635009497159, 1122.4443900269418, 1122.8203487442051, 1124.111951558268, 820.5609998650752, 822.576373167819, 822.6873787960596, 822.8560001999626, 823.1398188892622, 19803.801961980338, 20608.896955515276, 20810.791892081037, 20811.8959405202, 21251.149954001823, 21556.784432155633, 21718.89140554303, 22080.447988800246, 22150.446238843997, 22175.334739957827, 16796.580085497837, 17119.65760684792, 17140.057296848794, 17265.568360790956, 17283.48149555503, 3593.7843729376323, 3622.6739593436455, 3624.311380837659, 3627.075095850568, 3627.2201476682376, 130473.0, 131891.34054329764, 133256.0, 134999.0, 136589.0, 17159.142042897805, 17190.31238750436, 17261.741073883903, 17480.388186413413, 17606.471805845846, 30491.2377190572, 31730.365392692016, 32077.358452830813, 32159.35681286361, 32250.838745806122, 7537.283958023979, 7941.285284324438, 8548.829023419497, 8839.425437346552, 9046.05016473274, 4282.978585107055, 4363.040131171138, 4379.233634114017, 4380.211561918822, 4382.0, 5090.694558326512, 5170.1986192140275, 5198.298229739013, 5226.216067589816, 5279.313689220377, 1043.1289872956168, 1052.9526171322157, 1070.5824728355947, 1071.8552995345528, 1074.5057273654206, 677.6239187251024, 685.869684759894, 690.5062880040695, 699.6991293743637, 702.4275215699189, 11571.6528504145, 12191.207571507824, 12563.246205227715, 13375.732485350432, 13975.161490310615, 688.9069975553336, 694.2224708326706, 700.5621486570893, 702.5222848462992, 717.5228473065353, 5483.232347471358, 5877.529797616266, 5881.470667639933, 5902.468777810018, 5987.042073268343, 110529.44735276433, 110847.0, 111315.44342278237, 112561.0, 113431.43284283526, 99322.0, 102568.48715756374, 103127.86297550319, 104134.47932760288, 105357.47321263344, 88668.55665721631, 89090.10909890948, 89105.0, 90223.0, 92939.0, 11636.36000020007, 12073.744665576713, 12637.620871373874, 12641.557545486232, 12665.683357916127, 39495.0, 40446.38214471506, 41104.58895411008, 41282.38076428796, 42087.15825683408, 71953.0, 72367.0, 74456.62771686107, 74700.62649686934, 75332.24667753253, 17847.821521785136, 18053.368132115313, 18126.5468363292, 18224.817751822844, 18503.81496185021, 19214.8078519213, 19396.709049363988, 20766.584668306852, 21414.464638384165, 21761.0, 18858.905705471385, 19063.904680477062, 19116.522086947938, 19522.21911123596, 19568.412947611596, 18484.260629574666, 18806.435806925812, 19287.614247715246, 19296.61406771885, 20034.499137521096, 17600.207990640196, 17650.293988240326, 18016.2793488259, 18233.0, 18238.08809559543, 12221.633350999484, 12842.293673848028, 13142.0, 13184.60446186616, 13500.324983750577, 12284.1401101922, 13438.0, 13455.192688438725, 13541.932290338485, 14089.295535223402], "value": 9427.697024911296, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 95.0, 107.0, 108.0, 108.0, 111.0, 109.0, 109.0, 110.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 122.0, 143.0, 166.0, 121.0, 149.0, 150.0, 117.0, 175.0, 120.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 163.0, 164.0, 164.0, 162.0, 170.0, 164.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 167.0, 76.0, 76.0, 75.0, 75.0, 158.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 128.0, 80.0, 81.0, 80.0, 126.0, 79.0, 80.0, 129.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 115.0, 114.0, 115.0, 116.0, 114.0, 114.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 152.0, 150.0, 153.0, 150.0, 150.0, 151.0, 152.0, 149.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 93.0, 93.0, 94.0, 95.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 57.0, 54.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 56.0, 55.0, 55.0, 55.0, 56.0, 54.0, 55.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 82.0, 77.0, 76.0, 75.0, 76.0, 77.0, 79.0, 76.0, 78.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 123.0, 123.0, 129.0, 124.0, 134.0, 120.0, 123.0, 125.0, 178.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 177.0, 180.0, 183.0, 182.0, 174.0, 181.0, 171.0, 172.0, 190.0], "value": 180.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 68.0, 69.0, 68.0, 69.0, 67.0, 67.0, 71.0, 66.0], "value": 68.8, "unit": "score"}]}]} 04:14:10 INFO - Return code: 0 04:14:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:14:10 INFO - # TBPL SUCCESS # 04:14:10 INFO - Running post-action listener: _package_coverage_data 04:14:10 INFO - Running post-action listener: _resource_record_post_action 04:14:10 INFO - [mozharness: 2017-08-22 11:14:10.750217Z] Finished run-tests step (success) 04:14:10 INFO - Running post-run listener: _resource_record_post_run 04:14:10 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 436891648; Read time: 12; Write time: 439512 04:14:10 INFO - TinderboxPrint: CPU usage
13.1% 04:14:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:14:10 INFO - TinderboxPrint: I/O write bytes / time
436,891,648 / 439,512 04:14:10 INFO - TinderboxPrint: CPU idle
8,248.2 (86.9%) 04:14:10 INFO - TinderboxPrint: CPU user
1,198.5 (12.6%) 04:14:10 INFO - TinderboxPrint: Swap in / out
0 / 0 04:14:10 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 109064192; Read time: 0; Write time: 128916 04:14:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:14:10 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 327827456; Read time: 0; Write time: 310596 04:14:11 INFO - Running post-run listener: _upload_blobber_files 04:14:11 INFO - Blob upload gear active. 04:14:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:14:11 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 04:14:11 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'] 04:14:11 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 04:14:11 INFO - (blobuploader) - INFO - Open directory for files ... 04:14:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:14:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:14:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:12 INFO - (blobuploader) - INFO - Done attempting. 04:14:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:14:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:14:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:13 INFO - (blobuploader) - INFO - Done attempting. 04:14:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:14:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:14:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:14 INFO - (blobuploader) - INFO - Done attempting. 04:14:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:14:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:14:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:14:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:14:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:14:21 INFO - (blobuploader) - INFO - Done attempting. 04:14:21 INFO - (blobuploader) - INFO - Iteration through files over. 04:14:21 INFO - Return code: 0 04:14:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:14:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:14:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/699b10a63ae022cd56a13aeeeb4ccbd4b58b0d93510664280c1eb066adec7a0417325a8f95f7265d34d200934e9add844416e701e1637818fdaa62a195e9c05f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/155da0eb4b97ddcb33b2a1797ed00b04f2f7cc5dd495c442465bdde8a386cade0503ee523c65f15c22c3d273d2d10f2de3a53131f41793ae94acaa1a836b5316", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3e83c37d55aac18ff68bda78f5ac1773ef1a1977a9c9fed64aa996bb6a52100843a32403d5e0a5a3d29cc4ac4254999cbddda56236159446ef548e902dd6578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa82e3afffc3fa63c7d4c869504d2207a4fe52ed7c67eb29104f3b95ca0743c047495a540fbcad42aebf67e2dac6bf0229440ea214dcedcd8445ce5390c1e2e4"} 04:14:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:14:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:14:21 INFO - Contents: 04:14:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/699b10a63ae022cd56a13aeeeb4ccbd4b58b0d93510664280c1eb066adec7a0417325a8f95f7265d34d200934e9add844416e701e1637818fdaa62a195e9c05f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/155da0eb4b97ddcb33b2a1797ed00b04f2f7cc5dd495c442465bdde8a386cade0503ee523c65f15c22c3d273d2d10f2de3a53131f41793ae94acaa1a836b5316", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3e83c37d55aac18ff68bda78f5ac1773ef1a1977a9c9fed64aa996bb6a52100843a32403d5e0a5a3d29cc4ac4254999cbddda56236159446ef548e902dd6578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa82e3afffc3fa63c7d4c869504d2207a4fe52ed7c67eb29104f3b95ca0743c047495a540fbcad42aebf67e2dac6bf0229440ea214dcedcd8445ce5390c1e2e4"} 04:14:21 INFO - Running post-run listener: copy_logs_to_upload_dir 04:14:21 INFO - Copying logs to upload dir... 04:14:21 INFO - mkdir: /builds/slave/test/build/upload/logs 04:14:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.249655 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-22 04:14:21.326768) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 04:14:21.334910) ========= 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=c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/699b10a63ae022cd56a13aeeeb4ccbd4b58b0d93510664280c1eb066adec7a0417325a8f95f7265d34d200934e9add844416e701e1637818fdaa62a195e9c05f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/155da0eb4b97ddcb33b2a1797ed00b04f2f7cc5dd495c442465bdde8a386cade0503ee523c65f15c22c3d273d2d10f2de3a53131f41793ae94acaa1a836b5316", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3e83c37d55aac18ff68bda78f5ac1773ef1a1977a9c9fed64aa996bb6a52100843a32403d5e0a5a3d29cc4ac4254999cbddda56236159446ef548e902dd6578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa82e3afffc3fa63c7d4c869504d2207a4fe52ed7c67eb29104f3b95ca0743c047495a540fbcad42aebf67e2dac6bf0229440ea214dcedcd8445ce5390c1e2e4"} build_url:https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/XwXPZh4fRm2LDxf10gD67g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/699b10a63ae022cd56a13aeeeb4ccbd4b58b0d93510664280c1eb066adec7a0417325a8f95f7265d34d200934e9add844416e701e1637818fdaa62a195e9c05f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/155da0eb4b97ddcb33b2a1797ed00b04f2f7cc5dd495c442465bdde8a386cade0503ee523c65f15c22c3d273d2d10f2de3a53131f41793ae94acaa1a836b5316", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b3e83c37d55aac18ff68bda78f5ac1773ef1a1977a9c9fed64aa996bb6a52100843a32403d5e0a5a3d29cc4ac4254999cbddda56236159446ef548e902dd6578", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa82e3afffc3fa63c7d4c869504d2207a4fe52ed7c67eb29104f3b95ca0743c047495a540fbcad42aebf67e2dac6bf0229440ea214dcedcd8445ce5390c1e2e4"}' ========= master_lag: 0.07 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 04:14:21.417665) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 04:14:21.417975) ========= 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=c6927cf182745ad25b1d38b9000001fe-1503395146.196434-812009322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 04:14:21.457124) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 04:14:21.457400) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 04:14:21.457680) ========= ========= Total master_lag: 0.38 =========