builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1502228910.65 results: success (0) revision: 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.653141) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.653606) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.653881) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.700033) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.700327) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-08 14:48:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2017-08-08 14:48:30 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126899 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.855843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.856119) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018395 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:30.931100) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 14 secs) (at 2017-08-08 14:48:30.931438) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 --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 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 --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=9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-08 14:48:31,079 truncating revision to first 12 chars 2017-08-08 14:48:31,079 Setting DEBUG logging. 2017-08-08 14:48:31,079 attempt 1/10 2017-08-08 14:48:31,079 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/40004a53d1d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-08 14:48:32,508 attempt 1/10 2017-08-08 14:48:33,570 current task status: no status available at this point. state: STARTED 2017-08-08 14:48:33,570 sleeping for 11.00s (attempt 1/10) 2017-08-08 14:48:44,582 attempt 2/10 2017-08-08 14:48:44,895 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-08 14:48:45,114 unpacking tar archive at: mozilla-central-40004a53d1d1/testing/mozharness/ program finished with exit code 0 elapsedTime=14.374672 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 14 secs) (at 2017-08-08 14:48:45.340213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:45.340511) ========= script_repo_revision: 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:45.343925) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:45.344203) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 14:48:45.352730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-08 14:48:45.353039) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:48:45 INFO - MultiFileLogger online at 20170808 14:48:45 in /builds/slave/test 14:48:45 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 14:48:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:48:45 INFO - {'append_to_log': False, 14:48:45 INFO - 'base_work_dir': '/builds/slave/test', 14:48:45 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:48:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:48:45 INFO - 'branch': 'Firefox-Non-PGO', 14:48:45 INFO - 'buildbot_json_path': 'buildprops.json', 14:48:45 INFO - 'code_coverage': False, 14:48:45 INFO - 'config_files': ('talos/linux_config.py',), 14:48:45 INFO - 'default_actions': ('clobber', 14:48:45 INFO - 'read-buildbot-config', 14:48:45 INFO - 'download-and-extract', 14:48:45 INFO - 'populate-webroot', 14:48:45 INFO - 'create-virtualenv', 14:48:45 INFO - 'install', 14:48:45 INFO - 'setup-mitmproxy', 14:48:45 INFO - 'run-tests'), 14:48:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:48:45 INFO - 'disable_ccov_upload': False, 14:48:45 INFO - 'download_minidump_stackwalk': True, 14:48:45 INFO - 'download_symbols': 'ondemand', 14:48:45 INFO - 'enable_stylo': False, 14:48:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:48:45 INFO - 'tooltool.py': '/tools/tooltool.py', 14:48:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:48:45 INFO - '/tools/misc-python/virtualenv.py')}, 14:48:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:48:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:48:45 INFO - 'gecko_profile': False, 14:48:45 INFO - 'gecko_profile_interval': 0, 14:48:45 INFO - 'installer_path': 'installer.exe', 14:48:45 INFO - 'log_level': 'info', 14:48:45 INFO - 'log_name': 'talos', 14:48:45 INFO - 'log_to_console': True, 14:48:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:48:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:48:45 INFO - 'opt_config_files': (), 14:48:45 INFO - 'pip_index': False, 14:48:45 INFO - 'suite': 'dromaeojs-e10s', 14:48:45 INFO - 'system_bits': '32', 14:48:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:48:45 INFO - 'title': 'talos-linux64-ix-013', 14:48:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:48:45 INFO - 'use_talos_json': True, 14:48:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:48:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:48:45 INFO - 'work_dir': 'build'} 14:48:45 INFO - [mozharness: 2017-08-08 21:48:45.582064Z] Running clobber step. 14:48:45 INFO - Running pre-action listener: _resource_record_pre_action 14:48:45 INFO - Running main action method: clobber 14:48:45 INFO - rmtree: /builds/slave/test/build 14:48:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:48:45 INFO - Running post-action listener: _resource_record_post_action 14:48:45 INFO - [mozharness: 2017-08-08 21:48:45.585627Z] Finished clobber step (success) 14:48:45 INFO - [mozharness: 2017-08-08 21:48:45.585736Z] Running read-buildbot-config step. 14:48:45 INFO - Running pre-action listener: _resource_record_pre_action 14:48:45 INFO - Running main action method: read_buildbot_config 14:48:45 INFO - Using buildbot properties: 14:48:45 INFO - { 14:48:45 INFO - "project": "", 14:48:45 INFO - "product": "firefox", 14:48:45 INFO - "who": "kwierso@gmail.com", 14:48:45 INFO - "installer_path": "public/build/target.tar.bz2", 14:48:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:48:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:48:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:48:45 INFO - "stage_platform": "linux64", 14:48:45 INFO - "basedir": "/builds/slave/test", 14:48:45 INFO - "buildnumber": 764, 14:48:45 INFO - "platform": "ubuntu64_hw", 14:48:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:48:45 INFO - "slavebuilddir": "test", 14:48:45 INFO - "taskId": "ebjxgZBySOC23zdRYmA12g", 14:48:45 INFO - "branch": "mozilla-central", 14:48:45 INFO - "script_repo_revision": "production", 14:48:45 INFO - "revision": "40004a53d1d1a28b30f565ffc1329b1f28dfffd2", 14:48:45 INFO - "slavename": "talos-linux64-ix-013", 14:48:45 INFO - "repo_path": "mozilla-central" 14:48:45 INFO - } 14:48:45 INFO - Finding installer, test and symbols from parent task. 14:48:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ebjxgZBySOC23zdRYmA12g'}, attempt #1 14:48:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ebjxgZBySOC23zdRYmA12g'}, attempt #1 14:48:46 INFO - Task dependencies: ZRtnnw9hTj-zpiR_sx9VUw 14:48:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw'}, attempt #1 14:48:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 14:48:46 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.test_packages.json 14:48:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.crashreporter-symbols.zip 14:48:46 INFO - Running post-action listener: _resource_record_post_action 14:48:46 INFO - [mozharness: 2017-08-08 21:48:46.980162Z] Finished read-buildbot-config step (success) 14:48:46 INFO - [mozharness: 2017-08-08 21:48:46.980380Z] Running download-and-extract step. 14:48:46 INFO - Running pre-action listener: _resource_record_pre_action 14:48:46 INFO - Running main action method: download_and_extract 14:48:46 INFO - mkdir: /builds/slave/test/build/tests 14:48:46 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')]} 14:48:46 INFO - trying https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.test_packages.json 14:48:46 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:48:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:48:47 INFO - Downloaded 989 bytes. 14:48:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:48:47 INFO - Using the following test package requirements: 14:48:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:48:47 INFO - u'common': [u'target.common.tests.zip'], 14:48:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:48:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:48:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:48:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:48:47 INFO - u'mozbase': [u'target.common.tests.zip'], 14:48:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:48:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:48:47 INFO - u'web-platform': [u'target.common.tests.zip', 14:48:47 INFO - u'target.web-platform.tests.tar.gz'], 14:48:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:48:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:48:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip 14:48:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:48:47 INFO - Fetch https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip into memory 14:48:49 INFO - Content-Length response header: 54284810 14:48:49 INFO - Bytes received: 54284810 14:49:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:49:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip 14:49:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:49:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.common.tests.zip into memory 14:49:01 INFO - Content-Length response header: 54284810 14:49:01 INFO - Bytes received: 54284810 14:49:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.talos.tests.zip 14:49:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:49:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.talos.tests.zip into memory 14:49:15 INFO - Content-Length response header: 14496008 14:49:15 INFO - Bytes received: 14496008 14:49:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:15 INFO - trying https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 14:49:15 INFO - Downloading https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:49:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:49:18 INFO - Downloaded 61871458 bytes. 14:49:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 14:49:18 INFO - mkdir: /builds/slave/test/properties 14:49:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:49:18 INFO - Writing to file /builds/slave/test/properties/build_url 14:49:18 INFO - Contents: 14:49:18 INFO - build_url:https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 14:49:18 INFO - Running post-action listener: _resource_record_post_action 14:49:18 INFO - Running post-action listener: set_extra_try_arguments 14:49:18 INFO - [mozharness: 2017-08-08 21:49:18.404889Z] Finished download-and-extract step (success) 14:49:18 INFO - [mozharness: 2017-08-08 21:49:18.405121Z] Running populate-webroot step. 14:49:18 INFO - Running pre-action listener: _resource_record_pre_action 14:49:18 INFO - Running main action method: populate_webroot 14:49:18 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:49:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:49:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:49:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:49:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:49:18 INFO - 'tests': ['damp', 'tps']}, 14:49:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:49:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:49:18 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:49:18 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:49:18 INFO - 'other-e10s': {'tests': ['a11yr', 14:49:18 INFO - 'ts_paint', 14:49:18 INFO - 'tpaint', 14:49:18 INFO - 'sessionrestore', 14:49:18 INFO - 'sessionrestore_many_windows', 14:49:18 INFO - 'sessionrestore_no_auto_restore', 14:49:18 INFO - 'tabpaint']}, 14:49:18 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:49:18 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 14:49:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:49:18 INFO - 'tsvgr_opacity', 14:49:18 INFO - 'tart', 14:49:18 INFO - 'tscrollx', 14:49:18 INFO - 'tsvg_static']}, 14:49:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:49:18 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:49:18 INFO - 'talos_options': ['--mitmproxy', 14:49:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:49:18 INFO - '--firstNonBlankPaint'], 14:49:18 INFO - 'tests': ['tp6_google', 14:49:18 INFO - 'tp6_youtube', 14:49:18 INFO - 'tp6_amazon', 14:49:18 INFO - 'tp6_facebook']}, 14:49:18 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:49:18 INFO - 'talos_options': ['--stylo', 14:49:18 INFO - '--mitmproxy', 14:49:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:49:18 INFO - '--firstNonBlankPaint'], 14:49:18 INFO - 'tests': ['tp6_google', 14:49:18 INFO - 'tp6_youtube', 14:49:18 INFO - 'tp6_amazon', 14:49:18 INFO - 'tp6_facebook']}, 14:49:18 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:49:18 INFO - 'talos_options': ['--stylo', 14:49:18 INFO - '--stylo-threads=1', 14:49:18 INFO - '--mitmproxy', 14:49:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:49:18 INFO - '--firstNonBlankPaint'], 14:49:18 INFO - 'tests': ['tp6_google', 14:49:18 INFO - 'tp6_youtube', 14:49:18 INFO - 'tp6_amazon', 14:49:18 INFO - 'tp6_facebook']}, 14:49:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:49:18 INFO - 'talos_options': ['--xperf_path', 14:49:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:49:18 INFO - 'tests': ['tp5n']}}} 14:49:18 INFO - Running post-action listener: _resource_record_post_action 14:49:18 INFO - [mozharness: 2017-08-08 21:49:18.423573Z] Finished populate-webroot step (success) 14:49:18 INFO - [mozharness: 2017-08-08 21:49:18.423664Z] Running create-virtualenv step. 14:49:18 INFO - Running pre-action listener: _resource_record_pre_action 14:49:18 INFO - Running main action method: create_virtualenv 14:49:18 INFO - Creating virtualenv /builds/slave/test/build/venv 14:49:18 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 14:49:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:49:18 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:49:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:49:18 INFO - Using real prefix '/usr' 14:49:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:49:19 INFO - Installing distribute.............................................................................................................................................................................................done. 14:49:21 INFO - Installing pip.................done. 14:49:21 INFO - Return code: 0 14:49:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:49:21 INFO - Reading from file tmpfile_stdout 14:49:21 INFO - Output received: 14:49:21 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) 14:49:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268eb0>, '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 0x1269db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', '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 14:49:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:49:21 INFO - Using env: {'DISPLAY': ':0', 14:49:21 INFO - 'HOME': '/home/cltbld', 14:49:21 INFO - 'LANG': 'en_US.UTF-8', 14:49:21 INFO - 'LANGUAGE': 'en_US:en', 14:49:21 INFO - 'LOGNAME': 'cltbld', 14:49:21 INFO - 'MAIL': '/var/mail/cltbld', 14:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:21 INFO - 'MOZ_NO_REMOTE': '1', 14:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:21 INFO - 'NO_EM_RESTART': '1', 14:49:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:21 INFO - 'PWD': '/builds/slave/test', 14:49:21 INFO - 'SHELL': '/bin/bash', 14:49:21 INFO - 'SHLVL': '1', 14:49:21 INFO - 'TERM': 'linux', 14:49:21 INFO - 'TMOUT': '86400', 14:49:21 INFO - 'USER': 'cltbld', 14:49:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', 14:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:21 INFO - '_': '/tools/buildbot/bin/python'} 14:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:21 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 14:49:21 INFO - Cleaning up... 14:49:21 INFO - Return code: 0 14:49:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xefb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268eb0>, '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 0x1269db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', '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 14:49:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:49:21 INFO - Using env: {'DISPLAY': ':0', 14:49:21 INFO - 'HOME': '/home/cltbld', 14:49:21 INFO - 'LANG': 'en_US.UTF-8', 14:49:21 INFO - 'LANGUAGE': 'en_US:en', 14:49:21 INFO - 'LOGNAME': 'cltbld', 14:49:21 INFO - 'MAIL': '/var/mail/cltbld', 14:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:21 INFO - 'MOZ_NO_REMOTE': '1', 14:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:21 INFO - 'NO_EM_RESTART': '1', 14:49:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:21 INFO - 'PWD': '/builds/slave/test', 14:49:21 INFO - 'SHELL': '/bin/bash', 14:49:21 INFO - 'SHLVL': '1', 14:49:21 INFO - 'TERM': 'linux', 14:49:21 INFO - 'TMOUT': '86400', 14:49:21 INFO - 'USER': 'cltbld', 14:49:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', 14:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:21 INFO - '_': '/tools/buildbot/bin/python'} 14:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:21 INFO - Downloading/unpacking psutil>=3.1.1 14:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:49:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:49:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:49:22 INFO - Installing collected packages: psutil 14:49:22 INFO - Running setup.py install for psutil 14:49:22 INFO - building 'psutil._psutil_linux' extension 14:49:22 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 14:49:23 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 14:49:23 INFO - building 'psutil._psutil_posix' extension 14:49:23 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 14:49:23 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 14:49:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:49:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:49:23 INFO - Successfully installed psutil 14:49:23 INFO - Cleaning up... 14:49:23 INFO - Return code: 0 14:49:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:23 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 0xefb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268eb0>, '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 0x1269db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', '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 14:49:23 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 14:49:23 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 14:49:23 INFO - Using env: {'DISPLAY': ':0', 14:49:23 INFO - 'HOME': '/home/cltbld', 14:49:23 INFO - 'LANG': 'en_US.UTF-8', 14:49:23 INFO - 'LANGUAGE': 'en_US:en', 14:49:23 INFO - 'LOGNAME': 'cltbld', 14:49:23 INFO - 'MAIL': '/var/mail/cltbld', 14:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:23 INFO - 'MOZ_NO_REMOTE': '1', 14:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:23 INFO - 'NO_EM_RESTART': '1', 14:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:23 INFO - 'PWD': '/builds/slave/test', 14:49:23 INFO - 'SHELL': '/bin/bash', 14:49:23 INFO - 'SHLVL': '1', 14:49:23 INFO - 'TERM': 'linux', 14:49:23 INFO - 'TMOUT': '86400', 14:49:23 INFO - 'USER': 'cltbld', 14:49:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', 14:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:23 INFO - '_': '/tools/buildbot/bin/python'} 14:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:49:24 INFO - Installing collected packages: mozsystemmonitor 14:49:24 INFO - Running setup.py install for mozsystemmonitor 14:49:24 INFO - Successfully installed mozsystemmonitor 14:49:24 INFO - Cleaning up... 14:49:24 INFO - Return code: 0 14:49:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268eb0>, '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 0x1269db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', '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 14:49:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:49:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:49:24 INFO - Using env: {'DISPLAY': ':0', 14:49:24 INFO - 'HOME': '/home/cltbld', 14:49:24 INFO - 'LANG': 'en_US.UTF-8', 14:49:24 INFO - 'LANGUAGE': 'en_US:en', 14:49:24 INFO - 'LOGNAME': 'cltbld', 14:49:24 INFO - 'MAIL': '/var/mail/cltbld', 14:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:24 INFO - 'MOZ_NO_REMOTE': '1', 14:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:24 INFO - 'NO_EM_RESTART': '1', 14:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:24 INFO - 'PWD': '/builds/slave/test', 14:49:24 INFO - 'SHELL': '/bin/bash', 14:49:24 INFO - 'SHLVL': '1', 14:49:24 INFO - 'TERM': 'linux', 14:49:24 INFO - 'TMOUT': '86400', 14:49:24 INFO - 'USER': 'cltbld', 14:49:24 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', 14:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:24 INFO - '_': '/tools/buildbot/bin/python'} 14:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:25 INFO - Downloading/unpacking jsonschema==2.5.1 14:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:49:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:26 INFO - Downloading functools32-3.2.3-2.tar.gz 14:49:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:49:26 INFO - warning: no files found matching '*.txt' 14:49:26 INFO - no previously-included directories found matching 'build' 14:49:26 INFO - no previously-included directories found matching 'dist' 14:49:26 INFO - no previously-included directories found matching '.git*' 14:49:26 INFO - Installing collected packages: jsonschema, functools32 14:49:26 INFO - Running setup.py install for functools32 14:49:26 INFO - warning: no files found matching '*.txt' 14:49:26 INFO - no previously-included directories found matching 'build' 14:49:26 INFO - no previously-included directories found matching 'dist' 14:49:26 INFO - no previously-included directories found matching '.git*' 14:49:26 INFO - Successfully installed jsonschema functools32 14:49:26 INFO - Cleaning up... 14:49:26 INFO - Return code: 0 14:49:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268eb0>, '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 0x1269db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', '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 14:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:49:26 INFO - Using env: {'DISPLAY': ':0', 14:49:26 INFO - 'HOME': '/home/cltbld', 14:49:26 INFO - 'LANG': 'en_US.UTF-8', 14:49:26 INFO - 'LANGUAGE': 'en_US:en', 14:49:26 INFO - 'LOGNAME': 'cltbld', 14:49:26 INFO - 'MAIL': '/var/mail/cltbld', 14:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:26 INFO - 'MOZ_NO_REMOTE': '1', 14:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:26 INFO - 'NO_EM_RESTART': '1', 14:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:26 INFO - 'PWD': '/builds/slave/test', 14:49:26 INFO - 'SHELL': '/bin/bash', 14:49:26 INFO - 'SHLVL': '1', 14:49:26 INFO - 'TERM': 'linux', 14:49:26 INFO - 'TMOUT': '86400', 14:49:26 INFO - 'USER': 'cltbld', 14:49:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', 14:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:26 INFO - '_': '/tools/buildbot/bin/python'} 14:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:49:26 INFO - Cleaning up... 14:49:26 INFO - Return code: 0 14:49:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268eb0>, '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 0x1269db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', '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 14:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:49:26 INFO - Using env: {'DISPLAY': ':0', 14:49:26 INFO - 'HOME': '/home/cltbld', 14:49:26 INFO - 'LANG': 'en_US.UTF-8', 14:49:26 INFO - 'LANGUAGE': 'en_US:en', 14:49:26 INFO - 'LOGNAME': 'cltbld', 14:49:26 INFO - 'MAIL': '/var/mail/cltbld', 14:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:26 INFO - 'MOZ_NO_REMOTE': '1', 14:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:26 INFO - 'NO_EM_RESTART': '1', 14:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:26 INFO - 'PWD': '/builds/slave/test', 14:49:26 INFO - 'SHELL': '/bin/bash', 14:49:26 INFO - 'SHLVL': '1', 14:49:26 INFO - 'TERM': 'linux', 14:49:26 INFO - 'TMOUT': '86400', 14:49:26 INFO - 'USER': 'cltbld', 14:49:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', 14:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:26 INFO - '_': '/tools/buildbot/bin/python'} 14:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:26 INFO - Downloading/unpacking blobuploader==1.2.4 14:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:28 INFO - Downloading blobuploader-1.2.4.tar.gz 14:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:49:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:49:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:28 INFO - Downloading docopt-0.6.1.tar.gz 14:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:49:28 INFO - Installing collected packages: blobuploader, requests, docopt 14:49:28 INFO - Running setup.py install for blobuploader 14:49:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:49:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:49:28 INFO - Running setup.py install for requests 14:49:29 INFO - Running setup.py install for docopt 14:49:29 INFO - Successfully installed blobuploader requests docopt 14:49:29 INFO - Cleaning up... 14:49:29 INFO - Return code: 0 14:49:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49: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')]} 14:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:29 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 0xefb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268eb0>, '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 0x1269db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', '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 14:49:29 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 14:49:29 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 14:49:29 INFO - Using env: {'DISPLAY': ':0', 14:49:29 INFO - 'HOME': '/home/cltbld', 14:49:29 INFO - 'LANG': 'en_US.UTF-8', 14:49:29 INFO - 'LANGUAGE': 'en_US:en', 14:49:29 INFO - 'LOGNAME': 'cltbld', 14:49:29 INFO - 'MAIL': '/var/mail/cltbld', 14:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:29 INFO - 'MOZ_NO_REMOTE': '1', 14:49:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:29 INFO - 'NO_EM_RESTART': '1', 14:49:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:29 INFO - 'PWD': '/builds/slave/test', 14:49:29 INFO - 'SHELL': '/bin/bash', 14:49:29 INFO - 'SHLVL': '1', 14:49:29 INFO - 'TERM': 'linux', 14:49:29 INFO - 'TMOUT': '86400', 14:49:29 INFO - 'USER': 'cltbld', 14:49:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', 14:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:29 INFO - '_': '/tools/buildbot/bin/python'} 14:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:49:29 INFO - Running setup.py (path:/tmp/pip-CesE8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:49:29 INFO - Running setup.py (path:/tmp/pip-XepU5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:49:29 INFO - Running setup.py (path:/tmp/pip-g_2xEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:49:29 INFO - Running setup.py (path:/tmp/pip-GaWwsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:49:29 INFO - Running setup.py (path:/tmp/pip-oXCldg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:49:29 INFO - Running setup.py (path:/tmp/pip-wgGWV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:49:29 INFO - Running setup.py (path:/tmp/pip-OI8zxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:49:30 INFO - Running setup.py (path:/tmp/pip-qOQdVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:49:30 INFO - Running setup.py (path:/tmp/pip-4Qf9qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:49:30 INFO - Running setup.py (path:/tmp/pip-elDb4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:49:30 INFO - Running setup.py (path:/tmp/pip-yBl0nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:49:30 INFO - Running setup.py (path:/tmp/pip-WSzu82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:49:30 INFO - Running setup.py (path:/tmp/pip-qyEVSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:49:30 INFO - Running setup.py (path:/tmp/pip-tdsnZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:30 INFO - Running setup.py (path:/tmp/pip-vgSD6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:49:30 INFO - Running setup.py (path:/tmp/pip-P2Ig8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:49:30 INFO - Running setup.py (path:/tmp/pip-4xgbUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:49:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:49:30 INFO - Running setup.py install for manifestparser 14:49:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:49:30 INFO - Running setup.py install for mozcrash 14:49:30 INFO - Running setup.py install for mozdebug 14:49:31 INFO - Running setup.py install for mozdevice 14:49:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:49:31 INFO - Running setup.py install for mozfile 14:49:31 INFO - Running setup.py install for mozhttpd 14:49:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:49:31 INFO - Running setup.py install for mozinfo 14:49:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:49:31 INFO - Running setup.py install for mozInstall 14:49:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:49:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:49:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:49:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:49:31 INFO - Running setup.py install for mozleak 14:49:31 INFO - Running setup.py install for mozlog 14:49:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:49:31 INFO - Running setup.py install for moznetwork 14:49:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:49:31 INFO - Running setup.py install for mozprocess 14:49:31 INFO - Running setup.py install for mozprofile 14:49:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:49:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:49:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:49:32 INFO - Running setup.py install for mozrunner 14:49:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:49:32 INFO - Running setup.py install for mozscreenshot 14:49:32 INFO - Running setup.py install for moztest 14:49:32 INFO - Running setup.py install for mozversion 14:49:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:49:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:49:32 INFO - Cleaning up... 14:49:32 INFO - Return code: 0 14:49:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:32 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 0xefb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268eb0>, '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 0x1269db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', '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 14:49:32 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 14:49:32 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 14:49:32 INFO - Using env: {'DISPLAY': ':0', 14:49:32 INFO - 'HOME': '/home/cltbld', 14:49:32 INFO - 'LANG': 'en_US.UTF-8', 14:49:32 INFO - 'LANGUAGE': 'en_US:en', 14:49:32 INFO - 'LOGNAME': 'cltbld', 14:49:32 INFO - 'MAIL': '/var/mail/cltbld', 14:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:32 INFO - 'MOZ_NO_REMOTE': '1', 14:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:32 INFO - 'NO_EM_RESTART': '1', 14:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:32 INFO - 'PWD': '/builds/slave/test', 14:49:32 INFO - 'SHELL': '/bin/bash', 14:49:32 INFO - 'SHLVL': '1', 14:49:32 INFO - 'TERM': 'linux', 14:49:32 INFO - 'TMOUT': '86400', 14:49:32 INFO - 'USER': 'cltbld', 14:49:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', 14:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:32 INFO - '_': '/tools/buildbot/bin/python'} 14:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:49:32 INFO - Running setup.py (path:/tmp/pip-Cj2rhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:49:32 INFO - Running setup.py (path:/tmp/pip-heC0h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:49:32 INFO - Running setup.py (path:/tmp/pip-PIUxUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:49:32 INFO - Running setup.py (path:/tmp/pip-x1gDlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:49:32 INFO - Running setup.py (path:/tmp/pip-26Bcdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:49:33 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)) 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:49:33 INFO - Running setup.py (path:/tmp/pip-zCWDZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:49:33 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)) 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:49:33 INFO - Running setup.py (path:/tmp/pip-CcfL_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:49:33 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)) 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:49:33 INFO - Running setup.py (path:/tmp/pip-EbrmG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:49:33 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)) 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:49:33 INFO - Running setup.py (path:/tmp/pip-BX913V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:49:33 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)) 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:49:33 INFO - Running setup.py (path:/tmp/pip-Tu8z1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:49:33 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)) 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:49:33 INFO - Running setup.py (path:/tmp/pip-JDB3e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:49:33 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)) 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:49:33 INFO - Running setup.py (path:/tmp/pip-uXDIrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:49:33 INFO - Running setup.py (path:/tmp/pip-I8Dgc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:49:33 INFO - Running setup.py (path:/tmp/pip-UvubpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:33 INFO - Running setup.py (path:/tmp/pip-rPdTxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:49:33 INFO - Running setup.py (path:/tmp/pip-kOVUAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:49:33 INFO - Running setup.py (path:/tmp/pip-dgxEON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:49:33 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:49:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:34 INFO - Downloading blessings-1.6.tar.gz 14:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:49:35 INFO - Installing collected packages: blessings 14:49:35 INFO - Running setup.py install for blessings 14:49:35 INFO - Successfully installed blessings 14:49:35 INFO - Cleaning up... 14:49:35 INFO - Return code: 0 14:49:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:49:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:49:35 INFO - Reading from file tmpfile_stdout 14:49:35 INFO - Current package versions: 14:49:35 INFO - argparse == 1.2.1 14:49:35 INFO - blessings == 1.6 14:49:35 INFO - blobuploader == 1.2.4 14:49:35 INFO - docopt == 0.6.1 14:49:35 INFO - functools32 == 3.2.3-2 14:49:35 INFO - jsonschema == 2.5.1 14:49:35 INFO - manifestparser == 1.1 14:49:35 INFO - mozInstall == 1.13 14:49:35 INFO - mozcrash == 1.0 14:49:35 INFO - mozdebug == 0.1 14:49:35 INFO - mozdevice == 0.51 14:49:35 INFO - mozfile == 1.2 14:49:35 INFO - mozhttpd == 0.7 14:49:35 INFO - mozinfo == 0.10 14:49:35 INFO - mozleak == 0.1 14:49:35 INFO - mozlog == 3.5 14:49:35 INFO - moznetwork == 0.27 14:49:35 INFO - mozprocess == 0.25 14:49:35 INFO - mozprofile == 0.28 14:49:35 INFO - mozrunner == 6.13 14:49:35 INFO - mozscreenshot == 0.1 14:49:35 INFO - mozsystemmonitor == 0.3 14:49:35 INFO - moztest == 0.8 14:49:35 INFO - mozversion == 1.4 14:49:35 INFO - psutil == 3.1.1 14:49:35 INFO - requests == 1.2.3 14:49:35 INFO - wsgiref == 0.1.2 14:49:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:49:35 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')]} 14:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49:35 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')]} 14:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:35 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 0xefb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268eb0>, '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 0x1269db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', '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 14:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:49:35 INFO - Using env: {'DISPLAY': ':0', 14:49:35 INFO - 'HOME': '/home/cltbld', 14:49:35 INFO - 'LANG': 'en_US.UTF-8', 14:49:35 INFO - 'LANGUAGE': 'en_US:en', 14:49:35 INFO - 'LOGNAME': 'cltbld', 14:49:35 INFO - 'MAIL': '/var/mail/cltbld', 14:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:35 INFO - 'MOZ_NO_REMOTE': '1', 14:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:35 INFO - 'NO_EM_RESTART': '1', 14:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:35 INFO - 'PWD': '/builds/slave/test', 14:49:35 INFO - 'SHELL': '/bin/bash', 14:49:35 INFO - 'SHLVL': '1', 14:49:35 INFO - 'TERM': 'linux', 14:49:35 INFO - 'TMOUT': '86400', 14:49:35 INFO - 'USER': 'cltbld', 14:49:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', 14:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:35 INFO - '_': '/tools/buildbot/bin/python'} 14:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:49:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:49:35 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:49:36 INFO - Installing collected packages: simplejson 14:49:36 INFO - Running setup.py install for simplejson 14:49:37 INFO - building 'simplejson._speedups' extension 14:49:37 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 14:49:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 14:49:37 INFO - Successfully installed simplejson 14:49:37 INFO - Cleaning up... 14:49:37 INFO - Return code: 0 14:49:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:49: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')]} 14:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:49: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')]} 14:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:49:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x126bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1268eb0>, '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 0x1269db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', '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 14:49:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:49:37 INFO - Using env: {'DISPLAY': ':0', 14:49:37 INFO - 'HOME': '/home/cltbld', 14:49:37 INFO - 'LANG': 'en_US.UTF-8', 14:49:37 INFO - 'LANGUAGE': 'en_US:en', 14:49:37 INFO - 'LOGNAME': 'cltbld', 14:49:37 INFO - 'MAIL': '/var/mail/cltbld', 14:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:37 INFO - 'MOZ_NO_REMOTE': '1', 14:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:37 INFO - 'NO_EM_RESTART': '1', 14:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:37 INFO - 'PWD': '/builds/slave/test', 14:49:37 INFO - 'SHELL': '/bin/bash', 14:49:37 INFO - 'SHLVL': '1', 14:49:37 INFO - 'TERM': 'linux', 14:49:37 INFO - 'TMOUT': '86400', 14:49:37 INFO - 'USER': 'cltbld', 14:49:37 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', 14:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:37 INFO - '_': '/tools/buildbot/bin/python'} 14:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:49:38 INFO - Cleaning up... 14:49:38 INFO - Return code: 0 14:49:38 INFO - Running post-action listener: _resource_record_post_action 14:49:38 INFO - Running post-action listener: _start_resource_monitoring 14:49:38 INFO - Starting resource monitoring. 14:49:38 INFO - [mozharness: 2017-08-08 21:49:38.226965Z] Finished create-virtualenv step (success) 14:49:38 INFO - [mozharness: 2017-08-08 21:49:38.227431Z] Running install step. 14:49:38 INFO - Running pre-action listener: _resource_record_pre_action 14:49:38 INFO - Running main action method: install 14:49:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:49:38 INFO - Reading from file tmpfile_stdout 14:49:38 INFO - Detecting whether we're running mozinstall >=1.0... 14:49:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:49:38 INFO - Reading from file tmpfile_stdout 14:49:38 INFO - Output received: 14:49:38 INFO - Usage: mozinstall [options] installer 14:49:38 INFO - Options: 14:49:38 INFO - -h, --help show this help message and exit 14:49:38 INFO - -d DEST, --destination=DEST 14:49:38 INFO - Directory to install application into. [default: 14:49:38 INFO - "/builds/slave/test"] 14:49:38 INFO - --app=APP Application being installed. [default: firefox] 14:49:38 INFO - mkdir: /builds/slave/test/build/application 14:49:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:49:56 INFO - Reading from file tmpfile_stdout 14:49:56 INFO - Output received: 14:49:56 INFO - /builds/slave/test/build/application/firefox/firefox 14:49:56 INFO - Running post-action listener: _resource_record_post_action 14:49:56 INFO - [mozharness: 2017-08-08 21:49:56.521702Z] Finished install step (success) 14:49:56 INFO - [mozharness: 2017-08-08 21:49:56.521988Z] Running setup-mitmproxy step. 14:49:56 INFO - Running pre-action listener: _resource_record_pre_action 14:49:56 INFO - Running main action method: setup_mitmproxy 14:49:56 INFO - Skipping: mitmproxy is not required 14:49:56 INFO - Running post-action listener: _resource_record_post_action 14:49:56 INFO - [mozharness: 2017-08-08 21:49:56.523123Z] Finished setup-mitmproxy step (success) 14:49:56 INFO - [mozharness: 2017-08-08 21:49:56.523345Z] Running run-tests step. 14:49:56 INFO - Running pre-action listener: _resource_record_pre_action 14:49:56 INFO - Running pre-action listener: _set_gcov_prefix 14:49:56 INFO - Running main action method: run_tests 14:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:49:56 INFO - Python 2.7.3 14:49:56 INFO - Return code: 0 14:49:56 INFO - grabbing minidump binary from tooltool 14:49: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')]} 14:49:56 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 0x1268eb0>, '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 0x1269db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x126a240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:49:56 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 14:49:56 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 14:49:56 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 14:49:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:49:56 INFO - Return code: 0 14:49:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:49:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:49:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:49:56 INFO - ENV: RUST_BACKTRACE is now 1 14:49:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:49:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 14:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 14:49:56 INFO - Using env: {'DISPLAY': ':0', 14:49:56 INFO - 'HOME': '/home/cltbld', 14:49:56 INFO - 'LANG': 'en_US.UTF-8', 14:49:56 INFO - 'LANGUAGE': 'en_US:en', 14:49:56 INFO - 'LOGNAME': 'cltbld', 14:49:56 INFO - 'MAIL': '/var/mail/cltbld', 14:49:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:49:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:49:56 INFO - 'MOZ_NO_REMOTE': '1', 14:49:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:49:56 INFO - 'NO_EM_RESTART': '1', 14:49:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:49:56 INFO - 'PWD': '/builds/slave/test', 14:49:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:49:56 INFO - 'RUST_BACKTRACE': '1', 14:49:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:49:56 INFO - 'SHELL': '/bin/bash', 14:49:56 INFO - 'SHLVL': '1', 14:49:56 INFO - 'TERM': 'linux', 14:49:56 INFO - 'TMOUT': '86400', 14:49:56 INFO - 'USER': 'cltbld', 14:49:56 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969', 14:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:49:56 INFO - '_': '/tools/buildbot/bin/python'} 14:49:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 14:49:56 INFO - mozversion application_buildid: 20170808210507 14:49:56 INFO - mozversion application_changeset: 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 14:49:56 INFO - mozversion application_display_name: Nightly 14:49:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:49:56 INFO - mozversion application_name: Firefox 14:49:56 INFO - mozversion application_remotingname: firefox 14:49:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:49:56 INFO - mozversion application_vendor: Mozilla 14:49:56 INFO - mozversion application_version: 57.0a1 14:49:56 INFO - mozversion platform_buildid: 20170808210507 14:49:56 INFO - mozversion platform_changeset: 40004a53d1d1a28b30f565ffc1329b1f28dfffd2 14:49:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:49:56 INFO - mozversion platform_version: 57.0a1 14:49:56 INFO - using testdate: 1502228996 14:49:56 INFO - actual date: 1502228996 14:49:56 INFO - starting webserver on 'localhost:50858' 14:49:56 INFO - SUITE-START | Running 2 tests 14:49:56 INFO - TEST-START | dromaeo_css 14:49:56 INFO - Initialising browser for dromaeo_css test... 14:49:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50858/getInfo.html -profile /tmp/tmp4lshLa/profile 14:49:56 INFO - TEST-INFO | started process 15719 (/builds/slave/test/build/application/firefox/firefox http://localhost:50858/getInfo.html) 14:50:03 INFO - TEST-INFO | 15719: exit 0 14:50:03 INFO - Browser initialized. 14:50:03 INFO - Running cycle 1/1 for dromaeo_css test... 14:50:03 INFO - TEST-INFO | started process 15931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4lshLa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:50:04 INFO - PID 15931 | 14:50:04 INFO - PID 15931 | (/builds/slave/test/build/application/firefox/firefox:15979): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:50:04 INFO - PID 15931 | 14:50:14 INFO - PID 15931 | RSS: Main: 171524096 14:50:14 INFO - PID 15931 | 14:53:14 INFO - PID 15931 | Cycle 1(1): loaded http://localhost:50858/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50858/tests/dromaeo/cssquery-ext.html) 14:53:15 INFO - PID 15931 | RSS: Main: 172126208 14:53:15 INFO - PID 15931 | 14:56:17 INFO - PID 15931 | Cycle 1(1): loaded http://localhost:50858/tests/dromaeo/cssquery-ext.html (next: http://localhost:50858/tests/dromaeo/cssquery-jquery.html) 14:56:18 INFO - PID 15931 | RSS: Main: 171266048 14:56:18 INFO - PID 15931 | 14:59:19 INFO - PID 15931 | Cycle 1(1): loaded http://localhost:50858/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50858/tests/dromaeo/cssquery-mootools.html) 14:59:20 INFO - PID 15931 | RSS: Main: 172924928 14:59:20 INFO - PID 15931 | 15:02:22 INFO - PID 15931 | Cycle 1(1): loaded http://localhost:50858/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50858/tests/dromaeo/cssquery-prototype.html) 15:02:22 INFO - PID 15931 | RSS: Main: 171044864 15:02:22 INFO - PID 15931 | 15:05:26 INFO - PID 15931 | Cycle 1(1): loaded http://localhost:50858/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50858/tests/dromaeo/cssquery-yui.html) 15:05:27 INFO - PID 15931 | RSS: Main: 175128576 15:05:27 INFO - PID 15931 | 15:08:28 INFO - PID 15931 | Cycle 1(1): loaded http://localhost:50858/tests/dromaeo/cssquery-yui.html (next: http://localhost:50858/tests/dromaeo/cssquery-dojo.html) 15:08:29 INFO - PID 15931 | RSS: Main: 175091712 15:08:29 INFO - PID 15931 | 15:08:29 INFO - PID 15931 | __start_tp_report 15:08:29 INFO - PID 15931 | _x_x_mozilla_page_load 15:08:29 INFO - PID 15931 | _x_x_mozilla_page_load_details 15:08:29 INFO - PID 15931 | |i|pagename|runs| 15:08:29 INFO - PID 15931 | |0;dojo.html;3168.302973345863;3194.8402579871;3203.8946563435607;3225.4355487789644;3229.870805167794;6194.69026548673;6201.348858369874;6220.813375598728;6222.439980401763;6248.562600617958;6078.149059131725;6146.815595532141;6155.415235552616;6165.660888651122;6184;5674.773009079632;5693.117566777156;5695.77216911323;5717.828465146053;5754.424557544233;5714.228579141825;5716.714164291769;5720.914186287188;5733.140028995663;5739.426057394248;5746.1668058131545;5749.252597162363;5759.539236861062;5765.019946609086;5770.624909380897;5700.087985922253;5740.081586946089;5773.393793651648;5795.623284486495;5801.53587712982;5633.436656334375;5661.320641523043;5713.285839270091;5723.313202415737;5789.536837053026;5998.550108741862;6097.115918191882;6102.60333078353;6144.0783882417545;6175.042868355412;6582.341765823379;6602.735890564371;6637.767678131242;6645.900311495331;6649.268580456146;6599.47204223661;6601.141851559315;6683.966580167116;6702.899456508157;6707.49693772969;6188.226471691039;6203.2245969253845;6271.62370257786;6277.7802776903045;6285.842853928689;6731.394174524316;6818.727250910008;6828.0440738296675;6906.689198986058;6939.028536004963;6531.575447595891;6591.934080659132;6592.30780768022;6596.241432235259;6643.800685979429;6442.6778661066755;6616.801495955129;6626.56927299724;6642.535022548375;6661.134052573231;6636.336366363325;6637.568558043712;6718.0930574372815;6725.361090696376;6729.966350168218;6598.043283723833;6648.734050638017;6676.9666151668935;6681.966590167018;6781.287964763629;5341.145416733304;5356.732163391893;5369.087255166631;5378.9462105379225;5390.973045134828;4537.047220083819;4601.976990115028;4634.096351211481;4691.835785747482;4710.552497512731;5865.178874957509;5881.617694849907;5883.352831188566;5899.174115623816;5905.320888097838;6664;6684.030815531818;6695.631740254235;6775.119234499483;6806.353396427331;5716.514096301861;5776.740046697909;5781.913271300934;5826.533877289891;5845.181674565564;5842.503387212135;5866.823995280149;5883;5886.175935368966;5911.7635294587735;6408.807735767934;6478.967605162038;6483.189601299838;6488.805335839838;6514.4462720668325;5487.259220005249;6565.80302590923;6638.336166383516;6641.833954151185;6727.93272067273;6528.053432252392;6554.868902622016;6611.173603299588;6625.933740662532;6637.900431493628;6556.704948277244;6597.80206593803;6650.135482387259;6680.933190668031;6688.030235615711;6620.271770105381;6701.195856497252;6727.293634168342;6729.69716362755;6732.293109223657;6500.154979852589;6505.739770409131;6519.641419721961;6521.64130972801;6529.967350163219;6493.480521558358;6493.740250389931;6499.5775274607;6503.642299673564;6507.381798729113;5509.256250406304;6370.012648039561;6398.0083087121575;6401.679916004275;6422.197225346832;6536.705848236746;6543.214814222324;6575.079488871657;6644.867102658017;6660.766873159416;6275.121482992294;6325.588836725598;6359.046143078575;6415.582987105823;6423.42189202974 15:08:29 INFO - PID 15931 | |1;ext.html;853.5177624642076;881.722257488891;903.2638399704242;911.9361644684875;1184.7393573413856;30998.38003239934;32599.67400325999;43026.569734302684;43933.121337573306;44175.558244417545;44817.32774008392;45009.324860127126;45013.54986450134;45150.09699806002;45393.7730311348;7828.882566761503;7958.124606293303;7972.24263694951;7988.840223195532;7995.800104997364;7806.453548251625;7923.683052677886;7946.562939038379;7954.403419743513;7978.082520510157;7932.127465978738;7939;7975.800604984893;8003.639836207385;8005.559694216845;7915.2084791520965;7951.920480795205;7974.521528708238;8018.0779210390965;8020.318272946806;7743.457957942946;7845.411594130463;7873.291403773631;7874.60626968655;7894.2105789421175;40072;40246;40336.19327613431;40578.18843623111;40634.796826015976;3544.663256990582;3552;3578.838952247129;3596.065023093988;3596.1908570571672;32123;32130.03609891707;32201.677983220103;32344.35311293761;32497.51253731196;4780.689255198401;4930.186519224324;4933.235348520949;4951.777170027357;4958.8760280993265;191429;191656;192139;192500;192723.03638481858;47948;48095.278570821465;48097;48133;48153;50039.749801250764;50746.492535074176;50824.491755082716;50904.74547627238;50982;13884.861151388559;13979.231142287272;14000.439982400794;14020.649483762783;14021.929890350482;11273.774524509465;11277.379744113989;11304.039156671775;11331.886681133083;11343.376114313793;13907;14105.506307279196;14125.929370353082;14129.152250864776;14334;5198.254978137462;5211.348581427322;5223.817166399233;5302.814401495929;5354.3574771027725;974.1135566634329;975.7853272280087;982.2534873496052;984.8227319082633;994.6767300627325;22369.552608948055;22442;22563.66154507651;22627.773722262897;22634.66048009281;1064.2284343850802;1099.755720624162;1100.4002818463957;1106.6403418888733;1106.6956586938657;11947;11962.40187990597;11969.88030119705;12059;12075.637730868088;216691;218151;218768;229960;232702;57407.42592574021;57441.712791436614;57703.422965770646;57777;57782;1483.6216764724927;1524.207412145678;1531.7166324230054;1537.8231503377256;1543.3363653628824;27866;28118.43763124767;28193;28422.85788571044;28668.139955801358;53279.7336013333;53344;53628.73185634047;53776.193357100456;53813;204132;209308;209781;209899;209942;35784.284314313045;37604.81197594104;38033.09834508319;38079.238415232096;38174.236515270095;45058.32412513749;47024.529754703384;47050.76474617605;47365.52634473749;47574.52425475701;34240.828795855865;34456.483152752226;34487.4826877592;34495.482567761;34954.30091398107;33530.28433864914;33543.32913341768;33871;33990;34017.14957126092;37448.2510349786;37620.435693464075;37756.811215943744;38019.04952376213;38050.2389952205;32376.514352284263;32560;32894.50658240176;32947.67052329542;33534.832325838215;22671.773282266968;23470.76529234686;23677.17129900445;23704;24767.628485573092 15:08:29 INFO - PID 15931 | |2;jquery.html;568.545163868905;580.3645008715455;587.1486344800041;587.5563949218342;609.3479976425225;21447.356579302625;22493.775062249373;22502;22556.88721556394;22612;25842.483150336982;27703.445931081365;28052.158435246925;28083.719162808367;28103.57844632327;6683.164604424447;6861.588304701709;6862.416694580967;6867.656617169147;6868.347506986854;4001.4197941298494;4195.5175154857125;6642;6747.730090796363;6874.896876546856;7165.211826699059;7234.855302893939;7236.819079523001;7240.891386629179;7241.23966983467;7110.715571377139;7149.428045756327;7213.603251821148;7222.819429514252;7228.096487939008;7030.507864449491;7077.681504332318;7084.964575177091;7085.539439936388;7110.680019399139;31779.84110079458;32415.6758432415;32764.672353276637;33168.3366332672;33505.6649433505;1979.4358607796853;2035.2571311471354;2035.8065983731522;2036.3992622176345;2037.633226019316;20755;21337.25319613806;21378.144874205012;21385.251516197015;21388.786112138834;2555.961660575093;2570.87145642719;2652.0585192256663;2673.3851214220645;2696.2315740014;144695;150783.24608376998;151852;151915;152273;20588.691169632468;22001.009954552082;22274.220402285842;22787.31638050861;23733.643995340084;46579.76710116496;46670.06659866851;46878.5312146881;46975.76512117486;47125.057498849834;10974;11083.445827708581;11205.831912521156;11307.265027773168;11351.602693905674;8874.467531948103;8924.375293729376;8961.417507861968;9040.547972601344;9169;9281.72154835356;9379.24966002718;9393.577289021874;9693.273004524688;11450.484728187252;2614.1373346795513;2614.359481926902;2687.784977201819;2775.111964171446;2858.1425572328217;955.3408148377597;970.6942313171328;978.7553111722069;986.9407835529892;1003.909648131657;19665.606687866162;20357.796422035888;20689.0689918954;20726;20770.06534705942;1038.9168866490663;1043.5408420295046;1048.124815778818;1048.5805677728817;1053.1101219469535;10944.288621239593;11631.76736465266;11686.941565292289;13371.866281337063;13825.723485530232;488507;501238;502579;526365;532187;118772;123697.38151309185;129994;130889;130962.34518827536;1243.9004879609608;1294.799306107555;1306.6210798868412;1314.59247633234;1322.365264672943;21855.453613659785;21900.23349182771;21999.670004949618;22100.33698989033;22115.33653990383;61226.481321974716;61454.69272653608;61466.385336147854;63675.044874326;63781.36218637754;76837;77109;77150;77479.22520774721;79292;16445.835541644432;17584.912075440054;20665.380038598865;20716.482087947923;21431.57136857223;23344;24074.27777166688;24161.51676966486;24360;24589.401688890164;18831.623367532848;19051.904740476763;19069.809301906804;19148;19265.325713599956;16183.838161618703;16944.444444444543;17202.65594688124;17613.73579396336;17615.82384176142;18985.525361866064;19553.21787128499;19679.803201967796;19713.507162321057;19830.305939292055;20880;20917;20984;21093.789062109183;21104.788952110895;18754.343597974006;18782.530436738645;18932.905335473235;19070.904645476683;19103.61792764109 15:08:29 INFO - PID 15931 | |3;mootools.html;1333.3733145421652;1374.1205628397827;1394.1495687630538;1403.649087728068;1406.9577912662621;13424.66438339042;13820.723585528283;14001.719965600681;14018.299085045745;14020.929895350535;14601.123932564054;14678.266086695648;14794.556163315117;14804.703905921875;14848.03487773294;2723.6595425571854;2770.5844123381553;2771.6673999120035;2771.8752656130523;2772.209920172751;2647.0735242665105;2709.580015097663;2775.708550602188;2776.7362100600412;2780.402213524092;2658.56133737933;2719;2762.5165596020715;2770.34896799252;2780.708025657307;2677.8125531212822;2708.3093811078147;2714.6878109017516;2715.321169707573;2722.441899410626;2625.1993142091655;2640.7755340796057;2641.7094119647018;2658.6543749312464;2666.1734862192784;13713.314334283346;13761.036727429084;13934.372953217027;13954.372053257628;13983.510577129751;7612.276833700789;7874;7880.763577092639;7892.921070789276;7897.8025549361155;5060.367454068241;5204.3234379530795;5370.946290537084;5406.756695948692;5415.702136382497;1849.620793174278;1869.869109162359;1872.8595355348268;1918.2710569983456;1920.6830872905953;22586.096556137734;22745.090196392124;22749.658755118522;22751.772482275297;22788;6627;6649.301823308483;6691.705667204237;6770.322967703289;6796.388325050769;15223.162726050174;15286.617834554003;15303.61740956485;15311.846881531264;15351.616209594626;7438.814029649194;7627.199144089902;7633.770986870402;7634.8091297718;7639.732609358757;6188.876222475616;6210.553143005675;7097.62229653072;7136.250693677193;7167.641617919083;4945.950540494549;5071.264666623393;5102.08162530748;5118.974405128025;5128.358955130609;1436.490046033664;1470.6690994526145;1490.7391206538812;1498.7227362937892;1511.040489289309;902.2691619787993;914.07221670005;922.6632279218037;932.69687351611;940.2900809888628;7402.33378995893;7441.479096463196;7522.774316770506;7525.473216874876;7532.284432978859;726.0706295941204;726.3317747672154;746.3618606091821;746.3842330077707;755.3541721827759;4612.0545288215835;4629.282461218517;4857.854264372075;5258.765024864418;5409.810656626999;18473.353432629792;19315;19318;19324.8067519323;19384.903075484814;17963.550911227325;18974.71537926932;19023.714644280346;19089.331873384643;19184.13671384763;10301.690949271533;10450.581976720847;10456;10482.842757358645;10499.422531760674;8220.260176584135;8232.917670823215;8386.161383861565;8451.83096338082;8663.39356245082;16730.581735456224;16903.239354228845;17241.310347585957;17293.827061729222;17549.561260968578;17553.473395798148;17576.209070591598;17754.5561360967;17882.5529361767;18049;10237.692869213935;11130.55477780912;11456.140789440991;11469.598564050219;11470.885291146982;11944.402779860799;12699.746005080031;13039.348032598522;13075.280859552817;13109.147905386119;10835.212189988564;10860.131189504978;10956.945215273872;10974.506147223554;11102.2783519071;10262.692119236435;10632.627858024933;10636.946815265874;10737.89262107369;10917.945410272898;8093.635786389745;8200.42597018203;9275.814483710154;9585.664501742405;9616.423014619146;7282.781516554512;7291.125064992235;7319.121705395387;7322.48742588035;7376.852462950604;7448.627568621656;7462.10454745434;7474.7757567273065;7487.288707572772;7500.024996750388 15:08:29 INFO - PID 15931 | |4;prototype.html;489.7844948222782;503.49901847661573;515.7653267763168;525.3459442993474;531.5083547718359;6035.909461358072;6207.813765587029;6269.592476489025;6271.749130034799;6290.245170579531;5925.4963328117055;6080.635161890279;6093.695315234243;6126.479249263807;6134.9079763803575;4958.107540642692;4970.875728106808;4998.300237966688;5011.649184557083;5019.52314530119;4957.537526429712;4981.704756763232;5005.449400565934;5005.924911126336;5024.799008039674;4839.975800120995;4888.584470320009;4988.852563910303;4991.301217829507;5019.824306149286;4970.179920313144;4988.528384126691;4991.201407774739;5002.424721157077;5022.347094877661;4455.287154055368;4461.21928662486;4495.123450927071;4526.388937493429;4548.65814584695;5952;6005.279366476007;6036.5170786336985;6056.636601803906;6070.6661133637635;5674.205611214434;5678.4037676044245;5691.288588926384;5695.800646977377;5722.54219662426;6467.676616169219;6471.0940468334475;6627.635480048595;6628.966855165693;6655.80032599018;4894.41267047953;4901.264810278487;4906.582940450066;4912.852614421573;4927.457979622239;6834.6582670866255;6898.827529311757;6901.689423975933;6950.6177160256675;6982.406495447893;4981.036283411365;4990.600751939836;5061.645684802029;5078.314427552233;5080.415752188472;5037.219231019198;5048.444671086178;5079.4412614612365;5145.331106956071;5159.535641792257;5770.88458230833;5773.892529226802;5787.218725472091;5799.376174671099;5813.709314534341;6664.466842652576;6716.966415167893;6728.360805723449;6729.461643068543;6741.7303307868115;1669.2488380228704;1711.4865540337848;1746.8951862888268;1758.6922288599444;1785.9285628574712;1153.653903828848;1214.3017764785106;1232.580922486341;1239.547565138736;1248.7512487512488;5785.797497087582;5839.0147349901235;5843.5325173985975;5851.268591426072;5862.530997520188;6639.900401493981;6671.933280667228;6704.865902682017;6735.696893639798;6737.730490780314;5687.488126068673;5735.311762588516;5758.337791153987;5804.912926306109;5833.766649334064;3551.3430015447225;3559.074640593464;3592.8383222755037;3598.3163198992106;3608.1340478285547;6486;6510.576812507172;6536.934630653633;6545.639989800511;6555.2133743951035;6745.56153850008;6760.174752816811;6767.240517465494;6788.626625535544;6822.897656535156;6384.393482619051;6494.123293355431;6509.381608747161;6525.771597994048;6576.48740789621;6625.900611490735;6636.369544893228;6693.230278518033;6694.364035416627;6706.396424321834;6360.522960777867;6539.411452969255;6590.242122155822;6604.8348791280605;6651.368120028589;6438.420542151041;6479.838004049937;6522.184726909137;6544.411003009752;6584.967075164594;4993.850184494471;5004.799808007639;5009.248612708123;5018.322526459027;5037.345145131109;6623.602583844985;6637.103990961352;6658.766943156967;6681.09805176295;6726.293739157318;6465.547411681137;6479.708413121327;6548.377904099103;6560.967195163994;6601.33986601336;6497.512686548623;6509;6561.475081993524;6599.208095028627;6601.306862779531;5882.911756323744;6263.373662633882;6399.392057754506;6400.871982560416;6491.156149700509;6491.805245842632;6499.805005849832;6554.344565543408;6573.506986976092;6622.8344291393105;6292.653904035322;6324.932407782314;6425.421712045938;6447.4197322241225;6458.708258348255 15:08:29 INFO - PID 15931 | |5;yui.html;889.937704360695;915.7252824152753;922.916937475627;923.6490133749176;942.3874481586965;18246.27014919403;19129.139188736506;19162;19180.232790688355;19216.231350745955;20622.587548249026;21372.4656883578;21434.678479822775;21470.141194352207;21567.460813479673;984.1782111936524;1005.2510879394824;1007.1288335589735;1008.7326858382498;1010.5099026971913;999.7150812018576;1000.309786247487;1003.7440452684592;1004.256849931053;1005.3917379985113;940.8118376324728;1039.080413833755;1039.6309310194886;1039.682896716501;1046.6546039806844;1024.451918223754;1025.9487025648725;1026.7535791410082;1028.6142696488816;1035.2856528995007;754.3964828137468;756.9962150189269;758.0600055930662;758.287210022577;759.8594260061851;17979.640407191782;19368.70946935797;19411.3206037788;19457.80542194574;19462.80537194624;21035;21104.788952110437;21176;21453.249136280156;22518;16270.186490675418;16790.496285111465;16908.15459227046;17014.91492542542;17018.914905425518;3562.358775420423;3599.478075679012;3599.8740044098595;3602.2975519773654;3603.333383324067;121903.3904830479;122045;124042.37978810139;126166;126453;16894.49316520506;17376.739348909778;17420.303187872596;17535;17571.0335931525;30143.69856301453;30712;30748.385032299677;31425.685743142734;31475.213119672193;7648.464607477535;7975.7607271781935;8417.579121043924;8592.226699597066;8870.379073464925;4339.4792624884585;4389.517153113155;4394.648428125743;4418.337249412614;4419.734815911055;5112.258722485293;5213.244079608436;5234.895302094013;5248.343957005374;5265.420803711589;1042.4579218806177;1055.472263868066;1077.2297807067985;1077.8975997280245;1081.2053140941402;649.2371463530427;674.8076798112612;675.4697562413481;679.9456043516507;689.3106893106893;11115.277506962022;11925.642230733092;12088.038315745152;12293.200941938745;12543.3101179436;687.4156966578469;688.9699898651448;701.8701540214975;704.1198501872659;708.4509505133562;5447.428020057916;5559.861003474864;5568.888622227532;5571.637843540157;5729.1119876419225;104259;105455.4727226359;105773;106573;111382.44308778405;86328;87990.12009879947;88794.55602721946;90944;97277;79056;80164.59917700374;80739;82272;84633.15366846375;11841.822372664245;12210.206336588093;12333.075019373404;12398;12430.875691242973;33907.49138762871;34318.828405857814;35108.12229694278;35490.8225458871;35922.10194745048;44055.33916991184;44183;60753;62397;62758.68620656867;14425.134491930517;18677.159527821008;18928.33750818715;19233.326833560757;19724.112414941075;20709;21319.467013324793;21466;21576.892115539322;22046.779532204473;16904.746428803333;17407.82592174062;17819.554511137325;17885;18420.447386578424;18817;19091;19462.51343716362;19475.805241947965;19588.11853466626;17269.39557115495;18010.36963706264;18186.36347727823;18456.26174952987;18679.15943782506;9845.901540984498;10062;10143.949280253551;10205.642802501878;10387.948060259952;13397.866021339662;14070.296485175904;14260.928695356457;14483;14685.706285874008 15:08:29 INFO - PID 15931 | __end_tp_report 15:08:29 INFO - PID 15931 | __start_cc_report 15:08:29 INFO - PID 15931 | _x_x_mozilla_cycle_collect,359 15:08:29 INFO - PID 15931 | __end_cc_report 15:08:29 INFO - PID 15931 | __startTimestamp1502230109170__endTimestamp 15:08:29 INFO - PID 15931 | 15:08:29 INFO - PID 15931 | ------- Summary: start ------- 15:08:29 INFO - PID 15931 | Number of tests: 6 15:08:29 INFO - PID 15931 | 15:08:29 INFO - PID 15931 | [#0] dojo.html Cycles:165 Average:6137.61 Median:6401.68 stddev:716.06 (11.2%) stddev-sans-first:679.32 15:08:29 INFO - PID 15931 | Values: 3168.3 3194.8 3203.9 3225.4 3229.9 6194.7 6201.3 6220.8 6222.4 6248.6 6078.1 6146.8 6155.4 6165.7 6184.0 5674.8 5693.1 5695.8 5717.8 5754.4 5714.2 5716.7 5720.9 5733.1 5739.4 5746.2 5749.3 5759.5 5765.0 5770.6 5700.1 5740.1 5773.4 5795.6 5801.5 5633.4 5661.3 5713.3 5723.3 5789.5 5998.6 6097.1 6102.6 6144.1 6175.0 6582.3 6602.7 6637.8 6645.9 6649.3 6599.5 6601.1 6684.0 6702.9 6707.5 6188.2 6203.2 6271.6 6277.8 6285.8 6731.4 6818.7 6828.0 6906.7 6939.0 6531.6 6591.9 6592.3 6596.2 6643.8 6442.7 6616.8 6626.6 6642.5 6661.1 6636.3 6637.6 6718.1 6725.4 6730.0 6598.0 6648.7 6677.0 6682.0 6781.3 5341.1 5356.7 5369.1 5378.9 5391.0 4537.0 4602.0 4634.1 4691.8 4710.6 5865.2 5881.6 5883.4 5899.2 5905.3 6664.0 6684.0 6695.6 6775.1 6806.4 5716.5 5776.7 5781.9 5826.5 5845.2 5842.5 5866.8 5883.0 5886.2 5911.8 6408.8 6479.0 6483.2 6488.8 6514.4 5487.3 6565.8 6638.3 6641.8 6727.9 6528.1 6554.9 6611.2 6625.9 6637.9 6556.7 6597.8 6650.1 6680.9 6688.0 6620.3 6701.2 6727.3 6729.7 6732.3 6500.2 6505.7 6519.6 6521.6 6530.0 6493.5 6493.7 6499.6 6503.6 6507.4 5509.3 6370.0 6398.0 6401.7 6422.2 6536.7 6543.2 6575.1 6644.9 6660.8 6275.1 6325.6 6359.0 6415.6 6423.4 15:08:29 INFO - PID 15931 | 15:08:29 INFO - PID 15931 | [#1] ext.html Cycles:180 Average:38825.07 Median:37612.62 stddev:54087.60 (143.8%) stddev-sans-first:54164.18 15:08:29 INFO - PID 15931 | Values: 853.5 881.7 903.3 911.9 1184.7 30998.4 32599.7 43026.6 43933.1 44175.6 44817.3 45009.3 45013.5 45150.1 45393.8 7828.9 7958.1 7972.2 7988.8 7995.8 7806.5 7923.7 7946.6 7954.4 7978.1 7932.1 7939.0 7975.8 8003.6 8005.6 7915.2 7951.9 7974.5 8018.1 8020.3 7743.5 7845.4 7873.3 7874.6 7894.2 40072.0 40246.0 40336.2 40578.2 40634.8 3544.7 3552.0 3578.8 3596.1 3596.2 32123.0 32130.0 32201.7 32344.4 32497.5 4780.7 4930.2 4933.2 4951.8 4958.9 191429.0 191656.0 192139.0 192500.0 192723.0 47948.0 48095.3 48097.0 48133.0 48153.0 50039.7 50746.5 50824.5 50904.7 50982.0 13884.9 13979.2 14000.4 14020.6 14021.9 11273.8 11277.4 11304.0 11331.9 11343.4 13907.0 14105.5 14125.9 14129.2 14334.0 5198.3 5211.3 5223.8 5302.8 5354.4 974.1 975.8 982.3 984.8 994.7 22369.6 22442.0 22563.7 22627.8 22634.7 1064.2 1099.8 1100.4 1106.6 1106.7 11947.0 11962.4 11969.9 12059.0 12075.6 216691.0 218151.0 218768.0 229960.0 232702.0 57407.4 57441.7 57703.4 57777.0 57782.0 1483.6 1524.2 1531.7 1537.8 1543.3 27866.0 28118.4 28193.0 28422.9 28668.1 53279.7 53344.0 53628.7 53776.2 53813.0 204132.0 209308.0 209781.0 209899.0 209942.0 35784.3 37604.8 38033.1 38079.2 38174.2 45058.3 47024.5 47050.8 47365.5 47574.5 34240.8 34456.5 34487.5 34495.5 34954.3 33530.3 33543.3 33871.0 33990.0 34017.1 37448.3 37620.4 37756.8 38019.0 38050.2 32376.5 32560.0 32894.5 32947.7 33534.8 22671.8 23470.8 23677.2 23704.0 24767.6 15:08:29 INFO - PID 15931 | 15:08:29 INFO - PID 15931 | [#2] jquery.html Cycles:180 Average:38038.28 Median:23065.66 stddev:86355.20 (374.4%) stddev-sans-first:86551.62 15:08:29 INFO - PID 15931 | Values: 568.5 580.4 587.1 587.6 609.3 21447.4 22493.8 22502.0 22556.9 22612.0 25842.5 27703.4 28052.2 28083.7 28103.6 6683.2 6861.6 6862.4 6867.7 6868.3 4001.4 4195.5 6642.0 6747.7 6874.9 7165.2 7234.9 7236.8 7240.9 7241.2 7110.7 7149.4 7213.6 7222.8 7228.1 7030.5 7077.7 7085.0 7085.5 7110.7 31779.8 32415.7 32764.7 33168.3 33505.7 1979.4 2035.3 2035.8 2036.4 2037.6 20755.0 21337.3 21378.1 21385.3 21388.8 2556.0 2570.9 2652.1 2673.4 2696.2 144695.0 150783.2 151852.0 151915.0 152273.0 20588.7 22001.0 22274.2 22787.3 23733.6 46579.8 46670.1 46878.5 46975.8 47125.1 10974.0 11083.4 11205.8 11307.3 11351.6 8874.5 8924.4 8961.4 9040.5 9169.0 9281.7 9379.2 9393.6 9693.3 11450.5 2614.1 2614.4 2687.8 2775.1 2858.1 955.3 970.7 978.8 986.9 1003.9 19665.6 20357.8 20689.1 20726.0 20770.1 1038.9 1043.5 1048.1 1048.6 1053.1 10944.3 11631.8 11686.9 13371.9 13825.7 488507.0 501238.0 502579.0 526365.0 532187.0 118772.0 123697.4 129994.0 130889.0 130962.3 1243.9 1294.8 1306.6 1314.6 1322.4 21855.5 21900.2 21999.7 22100.3 22115.3 61226.5 61454.7 61466.4 63675.0 63781.4 76837.0 77109.0 77150.0 77479.2 79292.0 16445.8 17584.9 20665.4 20716.5 21431.6 23344.0 24074.3 24161.5 24360.0 24589.4 18831.6 19051.9 19069.8 19148.0 19265.3 16183.8 16944.4 17202.7 17613.7 17615.8 18985.5 19553.2 19679.8 19713.5 19830.3 20880.0 20917.0 20984.0 21093.8 21104.8 18754.3 18782.5 18932.9 19070.9 19103.6 15:08:29 INFO - PID 15931 | 15:08:29 INFO - PID 15931 | [#3] mootools.html Cycles:180 Average:8699.92 Median:2662.41 stddev:5886.72 (221.1%) stddev-sans-first:5877.21 15:08:29 INFO - PID 15931 | Values: 1333.4 1374.1 1394.1 1403.6 1407.0 13424.7 13820.7 14001.7 14018.3 14020.9 14601.1 14678.3 14794.6 14804.7 14848.0 2723.7 2770.6 2771.7 2771.9 2772.2 2647.1 2709.6 2775.7 2776.7 2780.4 2658.6 2719.0 2762.5 2770.3 2780.7 2677.8 2708.3 2714.7 2715.3 2722.4 2625.2 2640.8 2641.7 2658.7 2666.2 13713.3 13761.0 13934.4 13954.4 13983.5 7612.3 7874.0 7880.8 7892.9 7897.8 5060.4 5204.3 5370.9 5406.8 5415.7 1849.6 1869.9 1872.9 1918.3 1920.7 22586.1 22745.1 22749.7 22751.8 22788.0 6627.0 6649.3 6691.7 6770.3 6796.4 15223.2 15286.6 15303.6 15311.8 15351.6 7438.8 7627.2 7633.8 7634.8 7639.7 6188.9 6210.6 7097.6 7136.3 7167.6 4946.0 5071.3 5102.1 5119.0 5128.4 1436.5 1470.7 1490.7 1498.7 1511.0 902.3 914.1 922.7 932.7 940.3 7402.3 7441.5 7522.8 7525.5 7532.3 726.1 726.3 746.4 746.4 755.4 4612.1 4629.3 4857.9 5258.8 5409.8 18473.4 19315.0 19318.0 19324.8 19384.9 17963.6 18974.7 19023.7 19089.3 19184.1 10301.7 10450.6 10456.0 10482.8 10499.4 8220.3 8232.9 8386.2 8451.8 8663.4 16730.6 16903.2 17241.3 17293.8 17549.6 17553.5 17576.2 17754.6 17882.6 18049.0 10237.7 11130.6 11456.1 11469.6 11470.9 11944.4 12699.7 13039.3 13075.3 13109.1 10835.2 10860.1 10956.9 10974.5 11102.3 10262.7 10632.6 10636.9 10737.9 10917.9 8093.6 8200.4 9275.8 9585.7 9616.4 7282.8 7291.1 7319.1 7322.5 7376.9 7448.6 7462.1 7474.8 7487.3 7500.0 15:08:29 INFO - PID 15931 | 15:08:29 INFO - PID 15931 | [#4] prototype.html Cycles:180 Average:5509.16 Median:6046.58 stddev:1540.27 (25.5%) stddev-sans-first:1497.81 15:08:29 INFO - PID 15931 | Values: 489.8 503.5 515.8 525.3 531.5 6035.9 6207.8 6269.6 6271.7 6290.2 5925.5 6080.6 6093.7 6126.5 6134.9 4958.1 4970.9 4998.3 5011.6 5019.5 4957.5 4981.7 5005.4 5005.9 5024.8 4840.0 4888.6 4988.9 4991.3 5019.8 4970.2 4988.5 4991.2 5002.4 5022.3 4455.3 4461.2 4495.1 4526.4 4548.7 5952.0 6005.3 6036.5 6056.6 6070.7 5674.2 5678.4 5691.3 5695.8 5722.5 6467.7 6471.1 6627.6 6629.0 6655.8 4894.4 4901.3 4906.6 4912.9 4927.5 6834.7 6898.8 6901.7 6950.6 6982.4 4981.0 4990.6 5061.6 5078.3 5080.4 5037.2 5048.4 5079.4 5145.3 5159.5 5770.9 5773.9 5787.2 5799.4 5813.7 6664.5 6717.0 6728.4 6729.5 6741.7 1669.2 1711.5 1746.9 1758.7 1785.9 1153.7 1214.3 1232.6 1239.5 1248.8 5785.8 5839.0 5843.5 5851.3 5862.5 6639.9 6671.9 6704.9 6735.7 6737.7 5687.5 5735.3 5758.3 5804.9 5833.8 3551.3 3559.1 3592.8 3598.3 3608.1 6486.0 6510.6 6536.9 6545.6 6555.2 6745.6 6760.2 6767.2 6788.6 6822.9 6384.4 6494.1 6509.4 6525.8 6576.5 6625.9 6636.4 6693.2 6694.4 6706.4 6360.5 6539.4 6590.2 6604.8 6651.4 6438.4 6479.8 6522.2 6544.4 6585.0 4993.9 5004.8 5009.2 5018.3 5037.3 6623.6 6637.1 6658.8 6681.1 6726.3 6465.5 6479.7 6548.4 6561.0 6601.3 6497.5 6509.0 6561.5 6599.2 6601.3 5882.9 6263.4 6399.4 6400.9 6491.2 6491.8 6499.8 6554.3 6573.5 6622.8 6292.7 6324.9 6425.4 6447.4 6458.7 15:08:29 INFO - PID 15931 | 15:08:29 INFO - PID 15931 | [#5] yui.html Cycles:180 Average:22685.32 Median:20173.35 stddev:30415.31 (150.8%) stddev-sans-first:30456.61 15:08:29 INFO - PID 15931 | Values: 889.9 915.7 922.9 923.6 942.4 18246.3 19129.1 19162.0 19180.2 19216.2 20622.6 21372.5 21434.7 21470.1 21567.5 984.2 1005.3 1007.1 1008.7 1010.5 999.7 1000.3 1003.7 1004.3 1005.4 940.8 1039.1 1039.6 1039.7 1046.7 1024.5 1025.9 1026.8 1028.6 1035.3 754.4 757.0 758.1 758.3 759.9 17979.6 19368.7 19411.3 19457.8 19462.8 21035.0 21104.8 21176.0 21453.2 22518.0 16270.2 16790.5 16908.2 17014.9 17018.9 3562.4 3599.5 3599.9 3602.3 3603.3 121903.4 122045.0 124042.4 126166.0 126453.0 16894.5 17376.7 17420.3 17535.0 17571.0 30143.7 30712.0 30748.4 31425.7 31475.2 7648.5 7975.8 8417.6 8592.2 8870.4 4339.5 4389.5 4394.6 4418.3 4419.7 5112.3 5213.2 5234.9 5248.3 5265.4 1042.5 1055.5 1077.2 1077.9 1081.2 649.2 674.8 675.5 679.9 689.3 11115.3 11925.6 12088.0 12293.2 12543.3 687.4 689.0 701.9 704.1 708.5 5447.4 5559.9 5568.9 5571.6 5729.1 104259.0 105455.5 105773.0 106573.0 111382.4 86328.0 87990.1 88794.6 90944.0 97277.0 79056.0 80164.6 80739.0 82272.0 84633.2 11841.8 12210.2 12333.1 12398.0 12430.9 33907.5 34318.8 35108.1 35490.8 35922.1 44055.3 44183.0 60753.0 62397.0 62758.7 14425.1 18677.2 18928.3 19233.3 19724.1 20709.0 21319.5 21466.0 21576.9 22046.8 16904.7 17407.8 17819.6 17885.0 18420.4 18817.0 19091.0 19462.5 19475.8 19588.1 17269.4 18010.4 18186.4 18456.3 18679.2 9845.9 10062.0 10143.9 10205.6 10387.9 13397.9 14070.3 14260.9 14483.0 14685.7 15:08:29 INFO - PID 15931 | -------- Summary: end -------- 15:08:29 INFO - PID 15931 | 15:08:29 INFO - TEST-INFO | 15931: exit 0 15:08:29 INFO - TEST-OK | dromaeo_css | took 1113016ms 15:08:29 INFO - TEST-START | kraken 15:08:29 INFO - Initialising browser for kraken test... 15:08:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50858/getInfo.html -profile /tmp/tmpsgH2J0/profile 15:08:29 INFO - TEST-INFO | started process 16290 (/builds/slave/test/build/application/firefox/firefox http://localhost:50858/getInfo.html) 15:08:36 INFO - TEST-INFO | 16290: exit 0 15:08:36 INFO - Browser initialized. 15:08:36 INFO - Running cycle 1/1 for kraken test... 15:08:36 INFO - TEST-INFO | started process 16504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsgH2J0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:08:37 INFO - PID 16504 | 15:08:37 INFO - PID 16504 | (/builds/slave/test/build/application/firefox/firefox:16552): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:08:37 INFO - PID 16504 | 15:08:47 INFO - PID 16504 | RSS: Main: 168386560 15:08:47 INFO - PID 16504 | 15:08:50 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50858/tests/kraken/driver.html?testName=audio-beat-detection) 15:08:51 INFO - PID 16504 | RSS: Main: 173768704 15:08:51 INFO - PID 16504 | 15:08:53 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50858/tests/kraken/driver.html?testName=audio-dft) 15:08:54 INFO - PID 16504 | RSS: Main: 173662208 15:08:54 INFO - PID 16504 | 15:08:57 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50858/tests/kraken/driver.html?testName=audio-fft) 15:08:58 INFO - PID 16504 | RSS: Main: 167546880 15:08:58 INFO - PID 16504 | 15:09:00 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50858/tests/kraken/driver.html?testName=audio-oscillator) 15:09:00 INFO - PID 16504 | RSS: Main: 168726528 15:09:00 INFO - PID 16504 | 15:09:02 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50858/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:09:03 INFO - PID 16504 | RSS: Main: 168931328 15:09:03 INFO - PID 16504 | 15:09:06 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50858/tests/kraken/driver.html?testName=imaging-darkroom) 15:09:07 INFO - PID 16504 | RSS: Main: 171102208 15:09:07 INFO - PID 16504 | 15:09:10 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50858/tests/kraken/driver.html?testName=imaging-desaturate) 15:09:11 INFO - PID 16504 | RSS: Main: 171368448 15:09:11 INFO - PID 16504 | 15:09:14 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50858/tests/kraken/driver.html?testName=json-parse-financial) 15:09:14 INFO - PID 16504 | RSS: Main: 171839488 15:09:14 INFO - PID 16504 | 15:09:16 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50858/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:09:17 INFO - PID 16504 | RSS: Main: 171782144 15:09:17 INFO - PID 16504 | 15:09:18 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:09:19 INFO - PID 16504 | RSS: Main: 172359680 15:09:19 INFO - PID 16504 | 15:09:21 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:09:22 INFO - PID 16504 | RSS: Main: 172421120 15:09:22 INFO - PID 16504 | 15:09:24 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:09:25 INFO - PID 16504 | RSS: Main: 172748800 15:09:25 INFO - PID 16504 | 15:09:28 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:09:29 INFO - PID 16504 | RSS: Main: 172707840 15:09:29 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | Cycle 1(1): loaded http://localhost:50858/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50858/tests/kraken/driver.html?testName=ai-astar) 15:09:31 INFO - PID 16504 | RSS: Main: 174170112 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | __start_tp_report 15:09:31 INFO - PID 16504 | _x_x_mozilla_page_load 15:09:31 INFO - PID 16504 | _x_x_mozilla_page_load_details 15:09:31 INFO - PID 16504 | |i|pagename|runs| 15:09:31 INFO - PID 16504 | |0;ai-astar;99;107;102;108;109;109;108;100;106;109 15:09:31 INFO - PID 16504 | |1;audio-beat-detection;154;121;148;178;117;147;150;132;177;118 15:09:31 INFO - PID 16504 | |2;audio-dft;163;163;163;161;163;162;166;167;165;162 15:09:31 INFO - PID 16504 | |3;audio-fft;74;75;75;177;77;75;76;74;153;76 15:09:31 INFO - PID 16504 | |4;audio-oscillator;79;79;136;79;78;79;124;80;80;128 15:09:31 INFO - PID 16504 | |5;imaging-gaussian-blur;114;114;113;114;114;114;114;115;115;114 15:09:31 INFO - PID 16504 | |6;imaging-darkroom;153;150;150;150;150;152;150;150;151;152 15:09:31 INFO - PID 16504 | |7;imaging-desaturate;94;94;93;95;93;94;95;94;94;94 15:09:31 INFO - PID 16504 | |8;json-parse-financial;55;54;54;54;54;54;53;55;54;66 15:09:31 INFO - PID 16504 | |9;json-stringify-tinderbox;54;54;55;53;55;54;54;55;54;54 15:09:31 INFO - PID 16504 | |10;stanford-crypto-aes;78;88;88;88;80;87;79;78;81;78 15:09:31 INFO - PID 16504 | |11;stanford-crypto-ccm;130;127;131;128;126;137;126;136;128;171 15:09:31 INFO - PID 16504 | |12;stanford-crypto-pbkdf2;179;182;187;186;182;175;172;176;174;177 15:09:31 INFO - PID 16504 | |13;stanford-crypto-sha256-iterative;66;73;66;66;67;65;66;66;64;67 15:09:31 INFO - PID 16504 | __end_tp_report 15:09:31 INFO - PID 16504 | __start_cc_report 15:09:31 INFO - PID 16504 | _x_x_mozilla_cycle_collect,951 15:09:31 INFO - PID 16504 | __end_cc_report 15:09:31 INFO - PID 16504 | __startTimestamp1502230171336__endTimestamp 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | ------- Summary: start ------- 15:09:31 INFO - PID 16504 | Number of tests: 14 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#0] ai-astar Cycles:10 Average:105.70 Median:108.50 stddev:3.89 (3.6%) stddev-sans-first:3.28 15:09:31 INFO - PID 16504 | Values: 99.0 107.0 102.0 108.0 109.0 109.0 108.0 100.0 106.0 109.0 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:149.00 stddev:22.32 (15.0%) stddev-sans-first:23.39 15:09:31 INFO - PID 16504 | Values: 154.0 121.0 148.0 178.0 117.0 147.0 150.0 132.0 177.0 118.0 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:1.90 (1.2%) stddev-sans-first:2.01 15:09:31 INFO - PID 16504 | Values: 163.0 163.0 163.0 161.0 163.0 162.0 166.0 167.0 165.0 162.0 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#3] audio-fft Cycles:10 Average:93.20 Median:75.00 stddev:38.27 (51.0%) stddev-sans-first:39.96 15:09:31 INFO - PID 16504 | Values: 74.0 75.0 75.0 177.0 77.0 75.0 76.0 74.0 153.0 76.0 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:79.00 stddev:24.42 (30.9%) stddev-sans-first:25.28 15:09:31 INFO - PID 16504 | Values: 79.0 79.0 136.0 79.0 78.0 79.0 124.0 80.0 80.0 128.0 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 15:09:31 INFO - PID 16504 | Values: 114.0 114.0 113.0 114.0 114.0 114.0 114.0 115.0 115.0 114.0 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:150.50 stddev:1.14 (0.8%) stddev-sans-first:0.88 15:09:31 INFO - PID 16504 | Values: 153.0 150.0 150.0 150.0 150.0 152.0 150.0 150.0 151.0 152.0 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 15:09:31 INFO - PID 16504 | Values: 94.0 94.0 93.0 95.0 93.0 94.0 95.0 94.0 94.0 94.0 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:54.00 stddev:3.80 (7.0%) stddev-sans-first:4.03 15:09:31 INFO - PID 16504 | Values: 55.0 54.0 54.0 54.0 54.0 54.0 53.0 55.0 54.0 66.0 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 15:09:31 INFO - PID 16504 | Values: 54.0 54.0 55.0 53.0 55.0 54.0 54.0 55.0 54.0 54.0 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:84.00 stddev:4.62 (5.5%) stddev-sans-first:4.61 15:09:31 INFO - PID 16504 | Values: 78.0 88.0 88.0 88.0 80.0 87.0 79.0 78.0 81.0 78.0 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:130.50 stddev:13.56 (10.4%) stddev-sans-first:14.31 15:09:31 INFO - PID 16504 | Values: 130.0 127.0 131.0 128.0 126.0 137.0 126.0 136.0 128.0 171.0 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:180.50 stddev:5.10 (2.8%) stddev-sans-first:5.41 15:09:31 INFO - PID 16504 | Values: 179.0 182.0 187.0 186.0 182.0 175.0 172.0 176.0 174.0 177.0 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.00 stddev:2.41 (3.7%) stddev-sans-first:2.55 15:09:31 INFO - PID 16504 | Values: 66.0 73.0 66.0 66.0 67.0 65.0 66.0 66.0 64.0 67.0 15:09:31 INFO - PID 16504 | -------- Summary: end -------- 15:09:31 INFO - PID 16504 | 15:09:31 INFO - PID 16504 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:09:31 INFO - TEST-INFO | 16504: exit 0 15:09:32 INFO - TEST-OK | kraken | took 62132ms 15:09:32 INFO - SUITE-END | took 1175s 15:09:32 INFO - Completed test suite (00:19:35) 15:09:32 INFO - javascript benchmark 15:09:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8611.486651540486, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3168.302973345863, 3194.8402579871, 3203.8946563435607, 3225.4355487789644, 3229.870805167794, 6194.69026548673, 6201.348858369874, 6220.813375598728, 6222.439980401763, 6248.562600617958, 6078.149059131725, 6146.815595532141, 6155.415235552616, 6165.660888651122, 6184.0, 5674.773009079632, 5693.117566777156, 5695.77216911323, 5717.828465146053, 5754.424557544233, 5714.228579141825, 5716.714164291769, 5720.914186287188, 5733.140028995663, 5739.426057394248, 5746.1668058131545, 5749.252597162363, 5759.539236861062, 5765.019946609086, 5770.624909380897, 5700.087985922253, 5740.081586946089, 5773.393793651648, 5795.623284486495, 5801.53587712982, 5633.436656334375, 5661.320641523043, 5713.285839270091, 5723.313202415737, 5789.536837053026, 5998.550108741862, 6097.115918191882, 6102.60333078353, 6144.0783882417545, 6175.042868355412, 6582.341765823379, 6602.735890564371, 6637.767678131242, 6645.900311495331, 6649.268580456146, 6599.47204223661, 6601.141851559315, 6683.966580167116, 6702.899456508157, 6707.49693772969, 6188.226471691039, 6203.2245969253845, 6271.62370257786, 6277.7802776903045, 6285.842853928689, 6731.394174524316, 6818.727250910008, 6828.0440738296675, 6906.689198986058, 6939.028536004963, 6531.575447595891, 6591.934080659132, 6592.30780768022, 6596.241432235259, 6643.800685979429, 6442.6778661066755, 6616.801495955129, 6626.56927299724, 6642.535022548375, 6661.134052573231, 6636.336366363325, 6637.568558043712, 6718.0930574372815, 6725.361090696376, 6729.966350168218, 6598.043283723833, 6648.734050638017, 6676.9666151668935, 6681.966590167018, 6781.287964763629, 5341.145416733304, 5356.732163391893, 5369.087255166631, 5378.9462105379225, 5390.973045134828, 4537.047220083819, 4601.976990115028, 4634.096351211481, 4691.835785747482, 4710.552497512731, 5865.178874957509, 5881.617694849907, 5883.352831188566, 5899.174115623816, 5905.320888097838, 6664.0, 6684.030815531818, 6695.631740254235, 6775.119234499483, 6806.353396427331, 5716.514096301861, 5776.740046697909, 5781.913271300934, 5826.533877289891, 5845.181674565564, 5842.503387212135, 5866.823995280149, 5883.0, 5886.175935368966, 5911.7635294587735, 6408.807735767934, 6478.967605162038, 6483.189601299838, 6488.805335839838, 6514.4462720668325, 5487.259220005249, 6565.80302590923, 6638.336166383516, 6641.833954151185, 6727.93272067273, 6528.053432252392, 6554.868902622016, 6611.173603299588, 6625.933740662532, 6637.900431493628, 6556.704948277244, 6597.80206593803, 6650.135482387259, 6680.933190668031, 6688.030235615711, 6620.271770105381, 6701.195856497252, 6727.293634168342, 6729.69716362755, 6732.293109223657, 6500.154979852589, 6505.739770409131, 6519.641419721961, 6521.64130972801, 6529.967350163219, 6493.480521558358, 6493.740250389931, 6499.5775274607, 6503.642299673564, 6507.381798729113, 5509.256250406304, 6370.012648039561, 6398.0083087121575, 6401.679916004275, 6422.197225346832, 6536.705848236746, 6543.214814222324, 6575.079488871657, 6644.867102658017, 6660.766873159416, 6275.121482992294, 6325.588836725598, 6359.046143078575, 6415.582987105823, 6423.42189202974], "value": 6085.69813336437, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.5177624642076, 881.722257488891, 903.2638399704242, 911.9361644684875, 1184.7393573413856, 30998.38003239934, 32599.67400325999, 43026.569734302684, 43933.121337573306, 44175.558244417545, 44817.32774008392, 45009.324860127126, 45013.54986450134, 45150.09699806002, 45393.7730311348, 7828.882566761503, 7958.124606293303, 7972.24263694951, 7988.840223195532, 7995.800104997364, 7806.453548251625, 7923.683052677886, 7946.562939038379, 7954.403419743513, 7978.082520510157, 7932.127465978738, 7939.0, 7975.800604984893, 8003.639836207385, 8005.559694216845, 7915.2084791520965, 7951.920480795205, 7974.521528708238, 8018.0779210390965, 8020.318272946806, 7743.457957942946, 7845.411594130463, 7873.291403773631, 7874.60626968655, 7894.2105789421175, 40072.0, 40246.0, 40336.19327613431, 40578.18843623111, 40634.796826015976, 3544.663256990582, 3552.0, 3578.838952247129, 3596.065023093988, 3596.1908570571672, 32123.0, 32130.03609891707, 32201.677983220103, 32344.35311293761, 32497.51253731196, 4780.689255198401, 4930.186519224324, 4933.235348520949, 4951.777170027357, 4958.8760280993265, 191429.0, 191656.0, 192139.0, 192500.0, 192723.03638481858, 47948.0, 48095.278570821465, 48097.0, 48133.0, 48153.0, 50039.749801250764, 50746.492535074176, 50824.491755082716, 50904.74547627238, 50982.0, 13884.861151388559, 13979.231142287272, 14000.439982400794, 14020.649483762783, 14021.929890350482, 11273.774524509465, 11277.379744113989, 11304.039156671775, 11331.886681133083, 11343.376114313793, 13907.0, 14105.506307279196, 14125.929370353082, 14129.152250864776, 14334.0, 5198.254978137462, 5211.348581427322, 5223.817166399233, 5302.814401495929, 5354.3574771027725, 974.1135566634329, 975.7853272280087, 982.2534873496052, 984.8227319082633, 994.6767300627325, 22369.552608948055, 22442.0, 22563.66154507651, 22627.773722262897, 22634.66048009281, 1064.2284343850802, 1099.755720624162, 1100.4002818463957, 1106.6403418888733, 1106.6956586938657, 11947.0, 11962.40187990597, 11969.88030119705, 12059.0, 12075.637730868088, 216691.0, 218151.0, 218768.0, 229960.0, 232702.0, 57407.42592574021, 57441.712791436614, 57703.422965770646, 57777.0, 57782.0, 1483.6216764724927, 1524.207412145678, 1531.7166324230054, 1537.8231503377256, 1543.3363653628824, 27866.0, 28118.43763124767, 28193.0, 28422.85788571044, 28668.139955801358, 53279.7336013333, 53344.0, 53628.73185634047, 53776.193357100456, 53813.0, 204132.0, 209308.0, 209781.0, 209899.0, 209942.0, 35784.284314313045, 37604.81197594104, 38033.09834508319, 38079.238415232096, 38174.236515270095, 45058.32412513749, 47024.529754703384, 47050.76474617605, 47365.52634473749, 47574.52425475701, 34240.828795855865, 34456.483152752226, 34487.4826877592, 34495.482567761, 34954.30091398107, 33530.28433864914, 33543.32913341768, 33871.0, 33990.0, 34017.14957126092, 37448.2510349786, 37620.435693464075, 37756.811215943744, 38019.04952376213, 38050.2389952205, 32376.514352284263, 32560.0, 32894.50658240176, 32947.67052329542, 33534.832325838215, 22671.773282266968, 23470.76529234686, 23677.17129900445, 23704.0, 24767.628485573092], "value": 17617.388272048287, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.545163868905, 580.3645008715455, 587.1486344800041, 587.5563949218342, 609.3479976425225, 21447.356579302625, 22493.775062249373, 22502.0, 22556.88721556394, 22612.0, 25842.483150336982, 27703.445931081365, 28052.158435246925, 28083.719162808367, 28103.57844632327, 6683.164604424447, 6861.588304701709, 6862.416694580967, 6867.656617169147, 6868.347506986854, 4001.4197941298494, 4195.5175154857125, 6642.0, 6747.730090796363, 6874.896876546856, 7165.211826699059, 7234.855302893939, 7236.819079523001, 7240.891386629179, 7241.23966983467, 7110.715571377139, 7149.428045756327, 7213.603251821148, 7222.819429514252, 7228.096487939008, 7030.507864449491, 7077.681504332318, 7084.964575177091, 7085.539439936388, 7110.680019399139, 31779.84110079458, 32415.6758432415, 32764.672353276637, 33168.3366332672, 33505.6649433505, 1979.4358607796853, 2035.2571311471354, 2035.8065983731522, 2036.3992622176345, 2037.633226019316, 20755.0, 21337.25319613806, 21378.144874205012, 21385.251516197015, 21388.786112138834, 2555.961660575093, 2570.87145642719, 2652.0585192256663, 2673.3851214220645, 2696.2315740014, 144695.0, 150783.24608376998, 151852.0, 151915.0, 152273.0, 20588.691169632468, 22001.009954552082, 22274.220402285842, 22787.31638050861, 23733.643995340084, 46579.76710116496, 46670.06659866851, 46878.5312146881, 46975.76512117486, 47125.057498849834, 10974.0, 11083.445827708581, 11205.831912521156, 11307.265027773168, 11351.602693905674, 8874.467531948103, 8924.375293729376, 8961.417507861968, 9040.547972601344, 9169.0, 9281.72154835356, 9379.24966002718, 9393.577289021874, 9693.273004524688, 11450.484728187252, 2614.1373346795513, 2614.359481926902, 2687.784977201819, 2775.111964171446, 2858.1425572328217, 955.3408148377597, 970.6942313171328, 978.7553111722069, 986.9407835529892, 1003.909648131657, 19665.606687866162, 20357.796422035888, 20689.0689918954, 20726.0, 20770.06534705942, 1038.9168866490663, 1043.5408420295046, 1048.124815778818, 1048.5805677728817, 1053.1101219469535, 10944.288621239593, 11631.76736465266, 11686.941565292289, 13371.866281337063, 13825.723485530232, 488507.0, 501238.0, 502579.0, 526365.0, 532187.0, 118772.0, 123697.38151309185, 129994.0, 130889.0, 130962.34518827536, 1243.9004879609608, 1294.799306107555, 1306.6210798868412, 1314.59247633234, 1322.365264672943, 21855.453613659785, 21900.23349182771, 21999.670004949618, 22100.33698989033, 22115.33653990383, 61226.481321974716, 61454.69272653608, 61466.385336147854, 63675.044874326, 63781.36218637754, 76837.0, 77109.0, 77150.0, 77479.22520774721, 79292.0, 16445.835541644432, 17584.912075440054, 20665.380038598865, 20716.482087947923, 21431.57136857223, 23344.0, 24074.27777166688, 24161.51676966486, 24360.0, 24589.401688890164, 18831.623367532848, 19051.904740476763, 19069.809301906804, 19148.0, 19265.325713599956, 16183.838161618703, 16944.444444444543, 17202.65594688124, 17613.73579396336, 17615.82384176142, 18985.525361866064, 19553.21787128499, 19679.803201967796, 19713.507162321057, 19830.305939292055, 20880.0, 20917.0, 20984.0, 21093.789062109183, 21104.788952110895, 18754.343597974006, 18782.530436738645, 18932.905335473235, 19070.904645476683, 19103.61792764109], "value": 13200.495695748106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.3733145421652, 1374.1205628397827, 1394.1495687630538, 1403.649087728068, 1406.9577912662621, 13424.66438339042, 13820.723585528283, 14001.719965600681, 14018.299085045745, 14020.929895350535, 14601.123932564054, 14678.266086695648, 14794.556163315117, 14804.703905921875, 14848.03487773294, 2723.6595425571854, 2770.5844123381553, 2771.6673999120035, 2771.8752656130523, 2772.209920172751, 2647.0735242665105, 2709.580015097663, 2775.708550602188, 2776.7362100600412, 2780.402213524092, 2658.56133737933, 2719.0, 2762.5165596020715, 2770.34896799252, 2780.708025657307, 2677.8125531212822, 2708.3093811078147, 2714.6878109017516, 2715.321169707573, 2722.441899410626, 2625.1993142091655, 2640.7755340796057, 2641.7094119647018, 2658.6543749312464, 2666.1734862192784, 13713.314334283346, 13761.036727429084, 13934.372953217027, 13954.372053257628, 13983.510577129751, 7612.276833700789, 7874.0, 7880.763577092639, 7892.921070789276, 7897.8025549361155, 5060.367454068241, 5204.3234379530795, 5370.946290537084, 5406.756695948692, 5415.702136382497, 1849.620793174278, 1869.869109162359, 1872.8595355348268, 1918.2710569983456, 1920.6830872905953, 22586.096556137734, 22745.090196392124, 22749.658755118522, 22751.772482275297, 22788.0, 6627.0, 6649.301823308483, 6691.705667204237, 6770.322967703289, 6796.388325050769, 15223.162726050174, 15286.617834554003, 15303.61740956485, 15311.846881531264, 15351.616209594626, 7438.814029649194, 7627.199144089902, 7633.770986870402, 7634.8091297718, 7639.732609358757, 6188.876222475616, 6210.553143005675, 7097.62229653072, 7136.250693677193, 7167.641617919083, 4945.950540494549, 5071.264666623393, 5102.08162530748, 5118.974405128025, 5128.358955130609, 1436.490046033664, 1470.6690994526145, 1490.7391206538812, 1498.7227362937892, 1511.040489289309, 902.2691619787993, 914.07221670005, 922.6632279218037, 932.69687351611, 940.2900809888628, 7402.33378995893, 7441.479096463196, 7522.774316770506, 7525.473216874876, 7532.284432978859, 726.0706295941204, 726.3317747672154, 746.3618606091821, 746.3842330077707, 755.3541721827759, 4612.0545288215835, 4629.282461218517, 4857.854264372075, 5258.765024864418, 5409.810656626999, 18473.353432629792, 19315.0, 19318.0, 19324.8067519323, 19384.903075484814, 17963.550911227325, 18974.71537926932, 19023.714644280346, 19089.331873384643, 19184.13671384763, 10301.690949271533, 10450.581976720847, 10456.0, 10482.842757358645, 10499.422531760674, 8220.260176584135, 8232.917670823215, 8386.161383861565, 8451.83096338082, 8663.39356245082, 16730.581735456224, 16903.239354228845, 17241.310347585957, 17293.827061729222, 17549.561260968578, 17553.473395798148, 17576.209070591598, 17754.5561360967, 17882.5529361767, 18049.0, 10237.692869213935, 11130.55477780912, 11456.140789440991, 11469.598564050219, 11470.885291146982, 11944.402779860799, 12699.746005080031, 13039.348032598522, 13075.280859552817, 13109.147905386119, 10835.212189988564, 10860.131189504978, 10956.945215273872, 10974.506147223554, 11102.2783519071, 10262.692119236435, 10632.627858024933, 10636.946815265874, 10737.89262107369, 10917.945410272898, 8093.635786389745, 8200.42597018203, 9275.814483710154, 9585.664501742405, 9616.423014619146, 7282.781516554512, 7291.125064992235, 7319.121705395387, 7322.48742588035, 7376.852462950604, 7448.627568621656, 7462.10454745434, 7474.7757567273065, 7487.288707572772, 7500.024996750388], "value": 6354.068611773804, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.7844948222782, 503.49901847661573, 515.7653267763168, 525.3459442993474, 531.5083547718359, 6035.909461358072, 6207.813765587029, 6269.592476489025, 6271.749130034799, 6290.245170579531, 5925.4963328117055, 6080.635161890279, 6093.695315234243, 6126.479249263807, 6134.9079763803575, 4958.107540642692, 4970.875728106808, 4998.300237966688, 5011.649184557083, 5019.52314530119, 4957.537526429712, 4981.704756763232, 5005.449400565934, 5005.924911126336, 5024.799008039674, 4839.975800120995, 4888.584470320009, 4988.852563910303, 4991.301217829507, 5019.824306149286, 4970.179920313144, 4988.528384126691, 4991.201407774739, 5002.424721157077, 5022.347094877661, 4455.287154055368, 4461.21928662486, 4495.123450927071, 4526.388937493429, 4548.65814584695, 5952.0, 6005.279366476007, 6036.5170786336985, 6056.636601803906, 6070.6661133637635, 5674.205611214434, 5678.4037676044245, 5691.288588926384, 5695.800646977377, 5722.54219662426, 6467.676616169219, 6471.0940468334475, 6627.635480048595, 6628.966855165693, 6655.80032599018, 4894.41267047953, 4901.264810278487, 4906.582940450066, 4912.852614421573, 4927.457979622239, 6834.6582670866255, 6898.827529311757, 6901.689423975933, 6950.6177160256675, 6982.406495447893, 4981.036283411365, 4990.600751939836, 5061.645684802029, 5078.314427552233, 5080.415752188472, 5037.219231019198, 5048.444671086178, 5079.4412614612365, 5145.331106956071, 5159.535641792257, 5770.88458230833, 5773.892529226802, 5787.218725472091, 5799.376174671099, 5813.709314534341, 6664.466842652576, 6716.966415167893, 6728.360805723449, 6729.461643068543, 6741.7303307868115, 1669.2488380228704, 1711.4865540337848, 1746.8951862888268, 1758.6922288599444, 1785.9285628574712, 1153.653903828848, 1214.3017764785106, 1232.580922486341, 1239.547565138736, 1248.7512487512488, 5785.797497087582, 5839.0147349901235, 5843.5325173985975, 5851.268591426072, 5862.530997520188, 6639.900401493981, 6671.933280667228, 6704.865902682017, 6735.696893639798, 6737.730490780314, 5687.488126068673, 5735.311762588516, 5758.337791153987, 5804.912926306109, 5833.766649334064, 3551.3430015447225, 3559.074640593464, 3592.8383222755037, 3598.3163198992106, 3608.1340478285547, 6486.0, 6510.576812507172, 6536.934630653633, 6545.639989800511, 6555.2133743951035, 6745.56153850008, 6760.174752816811, 6767.240517465494, 6788.626625535544, 6822.897656535156, 6384.393482619051, 6494.123293355431, 6509.381608747161, 6525.771597994048, 6576.48740789621, 6625.900611490735, 6636.369544893228, 6693.230278518033, 6694.364035416627, 6706.396424321834, 6360.522960777867, 6539.411452969255, 6590.242122155822, 6604.8348791280605, 6651.368120028589, 6438.420542151041, 6479.838004049937, 6522.184726909137, 6544.411003009752, 6584.967075164594, 4993.850184494471, 5004.799808007639, 5009.248612708123, 5018.322526459027, 5037.345145131109, 6623.602583844985, 6637.103990961352, 6658.766943156967, 6681.09805176295, 6726.293739157318, 6465.547411681137, 6479.708413121327, 6548.377904099103, 6560.967195163994, 6601.33986601336, 6497.512686548623, 6509.0, 6561.475081993524, 6599.208095028627, 6601.306862779531, 5882.911756323744, 6263.373662633882, 6399.392057754506, 6400.871982560416, 6491.156149700509, 6491.805245842632, 6499.805005849832, 6554.344565543408, 6573.506986976092, 6622.8344291393105, 6292.653904035322, 6324.932407782314, 6425.421712045938, 6447.4197322241225, 6458.708258348255], "value": 5054.636423085403, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.937704360695, 915.7252824152753, 922.916937475627, 923.6490133749176, 942.3874481586965, 18246.27014919403, 19129.139188736506, 19162.0, 19180.232790688355, 19216.231350745955, 20622.587548249026, 21372.4656883578, 21434.678479822775, 21470.141194352207, 21567.460813479673, 984.1782111936524, 1005.2510879394824, 1007.1288335589735, 1008.7326858382498, 1010.5099026971913, 999.7150812018576, 1000.309786247487, 1003.7440452684592, 1004.256849931053, 1005.3917379985113, 940.8118376324728, 1039.080413833755, 1039.6309310194886, 1039.682896716501, 1046.6546039806844, 1024.451918223754, 1025.9487025648725, 1026.7535791410082, 1028.6142696488816, 1035.2856528995007, 754.3964828137468, 756.9962150189269, 758.0600055930662, 758.287210022577, 759.8594260061851, 17979.640407191782, 19368.70946935797, 19411.3206037788, 19457.80542194574, 19462.80537194624, 21035.0, 21104.788952110437, 21176.0, 21453.249136280156, 22518.0, 16270.186490675418, 16790.496285111465, 16908.15459227046, 17014.91492542542, 17018.914905425518, 3562.358775420423, 3599.478075679012, 3599.8740044098595, 3602.2975519773654, 3603.333383324067, 121903.3904830479, 122045.0, 124042.37978810139, 126166.0, 126453.0, 16894.49316520506, 17376.739348909778, 17420.303187872596, 17535.0, 17571.0335931525, 30143.69856301453, 30712.0, 30748.385032299677, 31425.685743142734, 31475.213119672193, 7648.464607477535, 7975.7607271781935, 8417.579121043924, 8592.226699597066, 8870.379073464925, 4339.4792624884585, 4389.517153113155, 4394.648428125743, 4418.337249412614, 4419.734815911055, 5112.258722485293, 5213.244079608436, 5234.895302094013, 5248.343957005374, 5265.420803711589, 1042.4579218806177, 1055.472263868066, 1077.2297807067985, 1077.8975997280245, 1081.2053140941402, 649.2371463530427, 674.8076798112612, 675.4697562413481, 679.9456043516507, 689.3106893106893, 11115.277506962022, 11925.642230733092, 12088.038315745152, 12293.200941938745, 12543.3101179436, 687.4156966578469, 688.9699898651448, 701.8701540214975, 704.1198501872659, 708.4509505133562, 5447.428020057916, 5559.861003474864, 5568.888622227532, 5571.637843540157, 5729.1119876419225, 104259.0, 105455.4727226359, 105773.0, 106573.0, 111382.44308778405, 86328.0, 87990.12009879947, 88794.55602721946, 90944.0, 97277.0, 79056.0, 80164.59917700374, 80739.0, 82272.0, 84633.15366846375, 11841.822372664245, 12210.206336588093, 12333.075019373404, 12398.0, 12430.875691242973, 33907.49138762871, 34318.828405857814, 35108.12229694278, 35490.8225458871, 35922.10194745048, 44055.33916991184, 44183.0, 60753.0, 62397.0, 62758.68620656867, 14425.134491930517, 18677.159527821008, 18928.33750818715, 19233.326833560757, 19724.112414941075, 20709.0, 21319.467013324793, 21466.0, 21576.892115539322, 22046.779532204473, 16904.746428803333, 17407.82592174062, 17819.554511137325, 17885.0, 18420.447386578424, 18817.0, 19091.0, 19462.51343716362, 19475.805241947965, 19588.11853466626, 17269.39557115495, 18010.36963706264, 18186.36347727823, 18456.26174952987, 18679.15943782506, 9845.901540984498, 10062.0, 10143.949280253551, 10205.642802501878, 10387.948060259952, 13397.866021339662, 14070.296485175904, 14260.928695356457, 14483.0, 14685.706285874008], "value": 8971.308840600743, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 102.0, 108.0, 109.0, 109.0, 108.0, 100.0, 106.0, 109.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 148.0, 178.0, 117.0, 147.0, 150.0, 132.0, 177.0, 118.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 161.0, 163.0, 162.0, 166.0, 167.0, 165.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 177.0, 77.0, 75.0, 76.0, 74.0, 153.0, 76.0], "value": 93.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 136.0, 79.0, 78.0, 79.0, 124.0, 80.0, 80.0, 128.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 150.0, 150.0, 150.0, 152.0, 150.0, 150.0, 151.0, 152.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 95.0, 93.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 55.0, 54.0, 66.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 53.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 88.0, 88.0, 88.0, 80.0, 87.0, 79.0, 78.0, 81.0, 78.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 127.0, 131.0, 128.0, 126.0, 137.0, 126.0, 136.0, 128.0, 171.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 182.0, 187.0, 186.0, 182.0, 175.0, 172.0, 176.0, 174.0, 177.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 66.0, 66.0, 67.0, 65.0, 66.0, 66.0, 64.0, 67.0], "value": 66.6, "unit": "score"}]}]} 15:09:32 INFO - Return code: 0 15:09:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:09:32 INFO - # TBPL SUCCESS # 15:09:32 INFO - Running post-action listener: _package_coverage_data 15:09:32 INFO - Running post-action listener: _resource_record_post_action 15:09:32 INFO - [mozharness: 2017-08-08 22:09:32.597824Z] Finished run-tests step (success) 15:09:32 INFO - Running post-run listener: _resource_record_post_run 15:09:32 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 436580352; Read time: 192; Write time: 371352 15:09:32 INFO - TinderboxPrint: CPU usage
13.1% 15:09:32 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 192 15:09:32 INFO - TinderboxPrint: I/O write bytes / time
436,580,352 / 371,352 15:09:32 INFO - TinderboxPrint: CPU idle
8,268.9 (86.8%) 15:09:32 INFO - TinderboxPrint: CPU user
1,202.0 (12.6%) 15:09:32 INFO - TinderboxPrint: Swap in / out
0 / 0 15:09:32 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 112631808; Read time: 0; Write time: 85692 15:09:32 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:09:32 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 323948544; Read time: 184; Write time: 285660 15:09:33 INFO - Running post-run listener: _upload_blobber_files 15:09:33 INFO - Blob upload gear active. 15:09:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:09:33 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 15:09:33 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'] 15:09:33 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 15:09:33 INFO - (blobuploader) - INFO - Open directory for files ... 15:09:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:09:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:09:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:34 INFO - (blobuploader) - INFO - Done attempting. 15:09:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:09:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:09:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:35 INFO - (blobuploader) - INFO - Done attempting. 15:09:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:09:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:09:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:41 INFO - (blobuploader) - INFO - Done attempting. 15:09:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:09:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:09:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:09:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:09:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:09:42 INFO - (blobuploader) - INFO - Done attempting. 15:09:42 INFO - (blobuploader) - INFO - Iteration through files over. 15:09:42 INFO - Return code: 0 15:09:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:09:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:09:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a886a89b6c583cdcf6d833e08c1856943fe2c7e64932e03d465c58d655f82a887a53e5b54cec7e235f8717101e91260e74862db325458a8bcabfe55543001514", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51e7480382acc8f2c4c76558a5f51060486f817ab08cd7571f4d2d8aa9511b22fcfa0e0c7d4f14846d85d69658384b9811a87fbebb0173dafe2f4c30eceec45b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f6f66d6296cc8a8661ab53b6a78f5f4b53fe804f88984ca192c48f474cc98af4e173784f3f0e06497644972d48c60b8ce01c0b985953c852b1ba2839cddd93d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4022996387c666504042789947a2db018ae38e30a20d593bc3c65ba2c7fee69d733a033934f893e0bd2a1b9ce1fcdb3a7d9e94a8602f7752d4aaf185768c6018"} 15:09:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:09:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:09:42 INFO - Contents: 15:09:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a886a89b6c583cdcf6d833e08c1856943fe2c7e64932e03d465c58d655f82a887a53e5b54cec7e235f8717101e91260e74862db325458a8bcabfe55543001514", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51e7480382acc8f2c4c76558a5f51060486f817ab08cd7571f4d2d8aa9511b22fcfa0e0c7d4f14846d85d69658384b9811a87fbebb0173dafe2f4c30eceec45b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f6f66d6296cc8a8661ab53b6a78f5f4b53fe804f88984ca192c48f474cc98af4e173784f3f0e06497644972d48c60b8ce01c0b985953c852b1ba2839cddd93d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4022996387c666504042789947a2db018ae38e30a20d593bc3c65ba2c7fee69d733a033934f893e0bd2a1b9ce1fcdb3a7d9e94a8602f7752d4aaf185768c6018"} 15:09:42 INFO - Running post-run listener: copy_logs_to_upload_dir 15:09:42 INFO - Copying logs to upload dir... 15:09:42 INFO - mkdir: /builds/slave/test/build/upload/logs 15:09:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.895135 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-08 15:09:42.294345) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 15:09:42.303001) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969 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/a886a89b6c583cdcf6d833e08c1856943fe2c7e64932e03d465c58d655f82a887a53e5b54cec7e235f8717101e91260e74862db325458a8bcabfe55543001514", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51e7480382acc8f2c4c76558a5f51060486f817ab08cd7571f4d2d8aa9511b22fcfa0e0c7d4f14846d85d69658384b9811a87fbebb0173dafe2f4c30eceec45b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f6f66d6296cc8a8661ab53b6a78f5f4b53fe804f88984ca192c48f474cc98af4e173784f3f0e06497644972d48c60b8ce01c0b985953c852b1ba2839cddd93d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4022996387c666504042789947a2db018ae38e30a20d593bc3c65ba2c7fee69d733a033934f893e0bd2a1b9ce1fcdb3a7d9e94a8602f7752d4aaf185768c6018"} build_url:https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011196 build_url: 'https://queue.taskcluster.net/v1/task/ZRtnnw9hTj-zpiR_sx9VUw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a886a89b6c583cdcf6d833e08c1856943fe2c7e64932e03d465c58d655f82a887a53e5b54cec7e235f8717101e91260e74862db325458a8bcabfe55543001514", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/51e7480382acc8f2c4c76558a5f51060486f817ab08cd7571f4d2d8aa9511b22fcfa0e0c7d4f14846d85d69658384b9811a87fbebb0173dafe2f4c30eceec45b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f6f66d6296cc8a8661ab53b6a78f5f4b53fe804f88984ca192c48f474cc98af4e173784f3f0e06497644972d48c60b8ce01c0b985953c852b1ba2839cddd93d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4022996387c666504042789947a2db018ae38e30a20d593bc3c65ba2c7fee69d733a033934f893e0bd2a1b9ce1fcdb3a7d9e94a8602f7752d4aaf185768c6018"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 15:09:42.327279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:09:42.330652) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502226281.391798-649494969 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.17 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:09:42.504779) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 15:09:42.505116) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 15:09:42.505466) ========= ========= Total master_lag: 0.35 =========