builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-080 starttime: 1501408891.18 results: success (0) revision: 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:31.175474) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:31.175862) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:31.176145) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:31.226524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:31.226823) ========= 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=781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-30 03:01:31-- 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% 225M=0s 2017-07-30 03:01:31 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130007 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:31.383431) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:31.383708) ========= 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=781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.078201 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:31.482614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:31.482909) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f --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 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f --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=781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-30 03:01:31,687 truncating revision to first 12 chars 2017-07-30 03:01:31,687 Setting DEBUG logging. 2017-07-30 03:01:31,687 attempt 1/10 2017-07-30 03:01:31,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6ee53b46474f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-30 03:01:32,123 unpacking tar archive at: mozilla-central-6ee53b46474f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.799350 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:32.294565) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:32.294859) ========= script_repo_revision: 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:32.298235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:32.298499) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-30 03:01:32.308258) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-07-30 03:01:32.308537) ========= /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=781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:01:32 INFO - MultiFileLogger online at 20170730 03:01:32 in /builds/slave/test 03:01:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:01:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:01:32 INFO - {'append_to_log': False, 03:01:32 INFO - 'base_work_dir': '/builds/slave/test', 03:01:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:01:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:01:32 INFO - 'branch': 'Firefox-Non-PGO', 03:01:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:01:32 INFO - 'code_coverage': False, 03:01:32 INFO - 'config_files': ('talos/linux_config.py',), 03:01:32 INFO - 'default_actions': ('clobber', 03:01:32 INFO - 'read-buildbot-config', 03:01:32 INFO - 'download-and-extract', 03:01:32 INFO - 'populate-webroot', 03:01:32 INFO - 'create-virtualenv', 03:01:32 INFO - 'install', 03:01:32 INFO - 'setup-mitmproxy', 03:01:32 INFO - 'run-tests'), 03:01:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:01:32 INFO - 'disable_ccov_upload': False, 03:01:32 INFO - 'download_minidump_stackwalk': True, 03:01:32 INFO - 'download_symbols': 'ondemand', 03:01:32 INFO - 'enable_stylo': False, 03:01:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:01:32 INFO - 'tooltool.py': '/tools/tooltool.py', 03:01:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:01:32 INFO - '/tools/misc-python/virtualenv.py')}, 03:01:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:01:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:01:32 INFO - 'gecko_profile': False, 03:01:32 INFO - 'gecko_profile_interval': 0, 03:01:32 INFO - 'installer_path': 'installer.exe', 03:01:32 INFO - 'log_level': 'info', 03:01:32 INFO - 'log_name': 'talos', 03:01:32 INFO - 'log_to_console': True, 03:01:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:01:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:01:32 INFO - 'opt_config_files': (), 03:01:32 INFO - 'pip_index': False, 03:01:32 INFO - 'suite': 'dromaeojs-e10s', 03:01:32 INFO - 'system_bits': '32', 03:01:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:01:32 INFO - 'title': 'talos-linux64-ix-080', 03:01:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:01:32 INFO - 'use_talos_json': True, 03:01:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:01:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:01:32 INFO - 'work_dir': 'build'} 03:01:32 INFO - [mozharness: 2017-07-30 10:01:32.743871Z] Running clobber step. 03:01:32 INFO - Running pre-action listener: _resource_record_pre_action 03:01:32 INFO - Running main action method: clobber 03:01:32 INFO - rmtree: /builds/slave/test/build 03:01:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:01:34 INFO - Running post-action listener: _resource_record_post_action 03:01:34 INFO - [mozharness: 2017-07-30 10:01:34.999263Z] Finished clobber step (success) 03:01:34 INFO - [mozharness: 2017-07-30 10:01:34.999448Z] Running read-buildbot-config step. 03:01:34 INFO - Running pre-action listener: _resource_record_pre_action 03:01:34 INFO - Running main action method: read_buildbot_config 03:01:35 INFO - Using buildbot properties: 03:01:35 INFO - { 03:01:35 INFO - "project": "", 03:01:35 INFO - "product": "firefox", 03:01:35 INFO - "who": "archaeopteryx@coole-files.de", 03:01:35 INFO - "installer_path": "public/build/target.tar.bz2", 03:01:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:01:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:01:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:01:35 INFO - "stage_platform": "linux64", 03:01:35 INFO - "basedir": "/builds/slave/test", 03:01:35 INFO - "buildnumber": 745, 03:01:35 INFO - "platform": "ubuntu64_hw", 03:01:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:01:35 INFO - "slavebuilddir": "test", 03:01:35 INFO - "taskId": "XcgIBsyeSe-LcPdZSFKNkA", 03:01:35 INFO - "branch": "mozilla-central", 03:01:35 INFO - "script_repo_revision": "production", 03:01:35 INFO - "revision": "6ee53b46474f74c231b1b569e8f2ecd9d0948a8f", 03:01:35 INFO - "slavename": "talos-linux64-ix-080", 03:01:35 INFO - "repo_path": "mozilla-central" 03:01:35 INFO - } 03:01:35 INFO - Finding installer, test and symbols from parent task. 03:01:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XcgIBsyeSe-LcPdZSFKNkA'}, attempt #1 03:01:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XcgIBsyeSe-LcPdZSFKNkA'}, attempt #1 03:01:35 INFO - Task dependencies: Ci-E2TbxTwSnTt2-E0Fjxw 03:01:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw'}, attempt #1 03:01:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2 03:01:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.test_packages.json 03:01:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.crashreporter-symbols.zip 03:01:36 INFO - Running post-action listener: _resource_record_post_action 03:01:36 INFO - [mozharness: 2017-07-30 10:01:36.369869Z] Finished read-buildbot-config step (success) 03:01:36 INFO - [mozharness: 2017-07-30 10:01:36.370187Z] Running download-and-extract step. 03:01:36 INFO - Running pre-action listener: _resource_record_pre_action 03:01:36 INFO - Running main action method: download_and_extract 03:01:36 INFO - mkdir: /builds/slave/test/build/tests 03:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:01:36 INFO - trying https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.test_packages.json 03:01:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:01:37 INFO - Downloaded 989 bytes. 03:01:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:01:37 INFO - Using the following test package requirements: 03:01:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:01:37 INFO - u'common': [u'target.common.tests.zip'], 03:01:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:01:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:01:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:01:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:01:37 INFO - u'mozbase': [u'target.common.tests.zip'], 03:01:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:01:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:01:37 INFO - u'web-platform': [u'target.common.tests.zip', 03:01:37 INFO - u'target.web-platform.tests.tar.gz'], 03:01:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:01:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:01:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.common.tests.zip 03:01:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:01:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.common.tests.zip into memory 03:01:39 INFO - Content-Length response header: 72565221 03:01:39 INFO - Bytes received: 72565221 03:01:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:01:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.common.tests.zip 03:01:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:01:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.common.tests.zip into memory 03:01:53 INFO - Content-Length response header: 72565221 03:01:53 INFO - Bytes received: 72565221 03:02:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.talos.tests.zip 03:02:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:02:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.talos.tests.zip into memory 03:02:06 INFO - Content-Length response header: 14496686 03:02:06 INFO - Bytes received: 14496686 03:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:06 INFO - trying https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2 03:02:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:02:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:02:08 INFO - Downloaded 62258448 bytes. 03:02:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2 03:02:08 INFO - mkdir: /builds/slave/test/properties 03:02:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:02:08 INFO - Writing to file /builds/slave/test/properties/build_url 03:02:08 INFO - Contents: 03:02:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2 03:02:08 INFO - Running post-action listener: _resource_record_post_action 03:02:08 INFO - Running post-action listener: set_extra_try_arguments 03:02:08 INFO - [mozharness: 2017-07-30 10:02:08.342710Z] Finished download-and-extract step (success) 03:02:08 INFO - [mozharness: 2017-07-30 10:02:08.342939Z] Running populate-webroot step. 03:02:08 INFO - Running pre-action listener: _resource_record_pre_action 03:02:08 INFO - Running main action method: populate_webroot 03:02:08 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:02:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:02:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:02:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:02:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:02:08 INFO - 'tests': ['damp', 'tps']}, 03:02:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:02:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:02:08 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:02:08 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:02:08 INFO - 'other-e10s': {'tests': ['a11yr', 03:02:08 INFO - 'ts_paint', 03:02:08 INFO - 'tpaint', 03:02:08 INFO - 'sessionrestore', 03:02:08 INFO - 'sessionrestore_many_windows', 03:02:08 INFO - 'sessionrestore_no_auto_restore', 03:02:08 INFO - 'tabpaint']}, 03:02:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:02:08 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:02:08 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:02:08 INFO - 'talos_options': ['--mitmproxy', 03:02:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:02:08 INFO - '--firstNonBlankPaint'], 03:02:08 INFO - 'tests': ['quantum_pageload_google', 03:02:08 INFO - 'quantum_pageload_youtube', 03:02:08 INFO - 'quantum_pageload_amazon', 03:02:08 INFO - 'quantum_pageload_facebook']}, 03:02:08 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:02:08 INFO - 'talos_options': ['--stylo', 03:02:08 INFO - '--mitmproxy', 03:02:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:02:08 INFO - '--firstNonBlankPaint'], 03:02:08 INFO - 'tests': ['quantum_pageload_google', 03:02:08 INFO - 'quantum_pageload_youtube', 03:02:08 INFO - 'quantum_pageload_amazon', 03:02:08 INFO - 'quantum_pageload_facebook']}, 03:02:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:02:08 INFO - 'tsvgr_opacity', 03:02:08 INFO - 'tart', 03:02:08 INFO - 'tscrollx', 03:02:08 INFO - 'cart', 03:02:08 INFO - 'tsvg_static']}, 03:02:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:02:08 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:02:08 INFO - 'talos_options': ['--stylo', 03:02:08 INFO - '--stylo-threads=1', 03:02:08 INFO - '--mitmproxy', 03:02:08 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:02:08 INFO - '--firstNonBlankPaint'], 03:02:08 INFO - 'tests': ['tp6_google', 03:02:08 INFO - 'tp6_youtube', 03:02:08 INFO - 'tp6_amazon', 03:02:08 INFO - 'tp6_facebook']}, 03:02:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:02:08 INFO - 'talos_options': ['--xperf_path', 03:02:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:02:08 INFO - 'tests': ['tp5n']}}} 03:02:08 INFO - Running post-action listener: _resource_record_post_action 03:02:08 INFO - [mozharness: 2017-07-30 10:02:08.355638Z] Finished populate-webroot step (success) 03:02:08 INFO - [mozharness: 2017-07-30 10:02:08.355728Z] Running create-virtualenv step. 03:02:08 INFO - Running pre-action listener: _resource_record_pre_action 03:02:08 INFO - Running main action method: create_virtualenv 03:02:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:02:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:02:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:02:08 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:02:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:02:08 INFO - Using real prefix '/usr' 03:02:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:02:09 INFO - Installing distribute.............................................................................................................................................................................................done. 03:02:11 INFO - Installing pip.................done. 03:02:11 INFO - Return code: 0 03:02:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:02:11 INFO - Reading from file tmpfile_stdout 03:02:11 INFO - Output received: 03:02:11 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:02:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:11 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 0x1a8e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfbeb0>, '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 0x1dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfd240>, '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': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:02:11 INFO - Using env: {'DISPLAY': ':0', 03:02:11 INFO - 'HOME': '/home/cltbld', 03:02:11 INFO - 'LANG': 'en_US.UTF-8', 03:02:11 INFO - 'LANGUAGE': 'en_US:en', 03:02:11 INFO - 'LOGNAME': 'cltbld', 03:02:11 INFO - 'MAIL': '/var/mail/cltbld', 03:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:11 INFO - 'MOZ_NO_REMOTE': '1', 03:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:11 INFO - 'NO_EM_RESTART': '1', 03:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:11 INFO - 'PWD': '/builds/slave/test', 03:02:11 INFO - 'SHELL': '/bin/bash', 03:02:11 INFO - 'SHLVL': '1', 03:02:11 INFO - 'TERM': 'linux', 03:02:11 INFO - 'TMOUT': '86400', 03:02:11 INFO - 'USER': 'cltbld', 03:02:11 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 03:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:11 INFO - '_': '/tools/buildbot/bin/python'} 03:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:02:11 INFO - Cleaning up... 03:02:11 INFO - Return code: 0 03:02:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:11 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 0x1a8e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfbeb0>, '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 0x1dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfd240>, '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': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:02:11 INFO - Using env: {'DISPLAY': ':0', 03:02:11 INFO - 'HOME': '/home/cltbld', 03:02:11 INFO - 'LANG': 'en_US.UTF-8', 03:02:11 INFO - 'LANGUAGE': 'en_US:en', 03:02:11 INFO - 'LOGNAME': 'cltbld', 03:02:11 INFO - 'MAIL': '/var/mail/cltbld', 03:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:11 INFO - 'MOZ_NO_REMOTE': '1', 03:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:11 INFO - 'NO_EM_RESTART': '1', 03:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:11 INFO - 'PWD': '/builds/slave/test', 03:02:11 INFO - 'SHELL': '/bin/bash', 03:02:11 INFO - 'SHLVL': '1', 03:02:11 INFO - 'TERM': 'linux', 03:02:11 INFO - 'TMOUT': '86400', 03:02:11 INFO - 'USER': 'cltbld', 03:02:11 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 03:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:11 INFO - '_': '/tools/buildbot/bin/python'} 03:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:11 INFO - Downloading/unpacking psutil>=3.1.1 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:02:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:02:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:02:13 INFO - Installing collected packages: psutil 03:02:13 INFO - Running setup.py install for psutil 03:02:13 INFO - building 'psutil._psutil_linux' extension 03:02:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:02:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:02:14 INFO - building 'psutil._psutil_posix' extension 03:02:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:02:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:02:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:02:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:02:14 INFO - Successfully installed psutil 03:02:14 INFO - Cleaning up... 03:02:14 INFO - Return code: 0 03:02:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfbeb0>, '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 0x1dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfd240>, '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': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:02:14 INFO - Using env: {'DISPLAY': ':0', 03:02:14 INFO - 'HOME': '/home/cltbld', 03:02:14 INFO - 'LANG': 'en_US.UTF-8', 03:02:14 INFO - 'LANGUAGE': 'en_US:en', 03:02:14 INFO - 'LOGNAME': 'cltbld', 03:02:14 INFO - 'MAIL': '/var/mail/cltbld', 03:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:14 INFO - 'MOZ_NO_REMOTE': '1', 03:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:14 INFO - 'NO_EM_RESTART': '1', 03:02:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:14 INFO - 'PWD': '/builds/slave/test', 03:02:14 INFO - 'SHELL': '/bin/bash', 03:02:14 INFO - 'SHLVL': '1', 03:02:14 INFO - 'TERM': 'linux', 03:02:14 INFO - 'TMOUT': '86400', 03:02:14 INFO - 'USER': 'cltbld', 03:02:14 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 03:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:14 INFO - '_': '/tools/buildbot/bin/python'} 03:02:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:02:15 INFO - Installing collected packages: mozsystemmonitor 03:02:15 INFO - Running setup.py install for mozsystemmonitor 03:02:15 INFO - Successfully installed mozsystemmonitor 03:02:15 INFO - Cleaning up... 03:02:15 INFO - Return code: 0 03:02:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02: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')]} 03:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:15 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 0x1a8e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfbeb0>, '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 0x1dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfd240>, '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': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:02:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:02:15 INFO - Using env: {'DISPLAY': ':0', 03:02:15 INFO - 'HOME': '/home/cltbld', 03:02:15 INFO - 'LANG': 'en_US.UTF-8', 03:02:15 INFO - 'LANGUAGE': 'en_US:en', 03:02:15 INFO - 'LOGNAME': 'cltbld', 03:02:15 INFO - 'MAIL': '/var/mail/cltbld', 03:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:15 INFO - 'MOZ_NO_REMOTE': '1', 03:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:15 INFO - 'NO_EM_RESTART': '1', 03:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:15 INFO - 'PWD': '/builds/slave/test', 03:02:15 INFO - 'SHELL': '/bin/bash', 03:02:15 INFO - 'SHLVL': '1', 03:02:15 INFO - 'TERM': 'linux', 03:02:15 INFO - 'TMOUT': '86400', 03:02:15 INFO - 'USER': 'cltbld', 03:02:15 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 03:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:15 INFO - '_': '/tools/buildbot/bin/python'} 03:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:16 INFO - Downloading/unpacking jsonschema==2.5.1 03:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:02:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:17 INFO - Downloading functools32-3.2.3-2.tar.gz 03:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:02:17 INFO - warning: no files found matching '*.txt' 03:02:17 INFO - no previously-included directories found matching 'build' 03:02:17 INFO - no previously-included directories found matching 'dist' 03:02:17 INFO - no previously-included directories found matching '.git*' 03:02:17 INFO - Installing collected packages: jsonschema, functools32 03:02:17 INFO - Running setup.py install for functools32 03:02:17 INFO - warning: no files found matching '*.txt' 03:02:17 INFO - no previously-included directories found matching 'build' 03:02:17 INFO - no previously-included directories found matching 'dist' 03:02:17 INFO - no previously-included directories found matching '.git*' 03:02:17 INFO - Successfully installed jsonschema functools32 03:02:17 INFO - Cleaning up... 03:02:17 INFO - Return code: 0 03:02:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:17 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 0x1a8e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfbeb0>, '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 0x1dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfd240>, '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': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:02:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:02:17 INFO - Using env: {'DISPLAY': ':0', 03:02:17 INFO - 'HOME': '/home/cltbld', 03:02:17 INFO - 'LANG': 'en_US.UTF-8', 03:02:17 INFO - 'LANGUAGE': 'en_US:en', 03:02:17 INFO - 'LOGNAME': 'cltbld', 03:02:17 INFO - 'MAIL': '/var/mail/cltbld', 03:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:17 INFO - 'MOZ_NO_REMOTE': '1', 03:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:17 INFO - 'NO_EM_RESTART': '1', 03:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:17 INFO - 'PWD': '/builds/slave/test', 03:02:17 INFO - 'SHELL': '/bin/bash', 03:02:17 INFO - 'SHLVL': '1', 03:02:17 INFO - 'TERM': 'linux', 03:02:17 INFO - 'TMOUT': '86400', 03:02:17 INFO - 'USER': 'cltbld', 03:02:17 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 03:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:17 INFO - '_': '/tools/buildbot/bin/python'} 03:02:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:02:17 INFO - Cleaning up... 03:02:17 INFO - Return code: 0 03:02:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:17 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 0x1a8e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfbeb0>, '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 0x1dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfd240>, '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': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:02:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:02:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:02:17 INFO - Using env: {'DISPLAY': ':0', 03:02:17 INFO - 'HOME': '/home/cltbld', 03:02:17 INFO - 'LANG': 'en_US.UTF-8', 03:02:17 INFO - 'LANGUAGE': 'en_US:en', 03:02:17 INFO - 'LOGNAME': 'cltbld', 03:02:17 INFO - 'MAIL': '/var/mail/cltbld', 03:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:17 INFO - 'MOZ_NO_REMOTE': '1', 03:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:17 INFO - 'NO_EM_RESTART': '1', 03:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:17 INFO - 'PWD': '/builds/slave/test', 03:02:17 INFO - 'SHELL': '/bin/bash', 03:02:17 INFO - 'SHLVL': '1', 03:02:17 INFO - 'TERM': 'linux', 03:02:17 INFO - 'TMOUT': '86400', 03:02:17 INFO - 'USER': 'cltbld', 03:02:17 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 03:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:17 INFO - '_': '/tools/buildbot/bin/python'} 03:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:18 INFO - Downloading/unpacking blobuploader==1.2.4 03:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:19 INFO - Downloading blobuploader-1.2.4.tar.gz 03:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:02:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:02:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:19 INFO - Downloading docopt-0.6.1.tar.gz 03:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:02:19 INFO - Installing collected packages: blobuploader, requests, docopt 03:02:19 INFO - Running setup.py install for blobuploader 03:02:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:02:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:02:19 INFO - Running setup.py install for requests 03:02:20 INFO - Running setup.py install for docopt 03:02:20 INFO - Successfully installed blobuploader requests docopt 03:02:20 INFO - Cleaning up... 03:02:20 INFO - Return code: 0 03:02:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:20 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 0x1a8e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfbeb0>, '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 0x1dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfd240>, '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': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:02:20 INFO - Using env: {'DISPLAY': ':0', 03:02:20 INFO - 'HOME': '/home/cltbld', 03:02:20 INFO - 'LANG': 'en_US.UTF-8', 03:02:20 INFO - 'LANGUAGE': 'en_US:en', 03:02:20 INFO - 'LOGNAME': 'cltbld', 03:02:20 INFO - 'MAIL': '/var/mail/cltbld', 03:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:20 INFO - 'MOZ_NO_REMOTE': '1', 03:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:20 INFO - 'NO_EM_RESTART': '1', 03:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:20 INFO - 'PWD': '/builds/slave/test', 03:02:20 INFO - 'SHELL': '/bin/bash', 03:02:20 INFO - 'SHLVL': '1', 03:02:20 INFO - 'TERM': 'linux', 03:02:20 INFO - 'TMOUT': '86400', 03:02:20 INFO - 'USER': 'cltbld', 03:02:20 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 03:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:20 INFO - '_': '/tools/buildbot/bin/python'} 03:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:20 INFO - Running setup.py (path:/tmp/pip-PmOF1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:20 INFO - Running setup.py (path:/tmp/pip-vGT4B4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:20 INFO - Running setup.py (path:/tmp/pip-zgB30_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:20 INFO - Running setup.py (path:/tmp/pip-4gVvFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:20 INFO - Running setup.py (path:/tmp/pip-gAEx97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:20 INFO - Running setup.py (path:/tmp/pip-GV1Si0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:20 INFO - Running setup.py (path:/tmp/pip-tXTnuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:21 INFO - Running setup.py (path:/tmp/pip-BX3n8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:21 INFO - Running setup.py (path:/tmp/pip-A9eDkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:21 INFO - Running setup.py (path:/tmp/pip-IGuAV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:21 INFO - Running setup.py (path:/tmp/pip-hckxqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:21 INFO - Running setup.py (path:/tmp/pip-f3MkjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:21 INFO - Running setup.py (path:/tmp/pip-5e2hBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:21 INFO - Running setup.py (path:/tmp/pip-onhBNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:21 INFO - Running setup.py (path:/tmp/pip-XqgFWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:21 INFO - Running setup.py (path:/tmp/pip-_SnGhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:21 INFO - Running setup.py (path:/tmp/pip-pMTL49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:02:21 INFO - Running setup.py install for manifestparser 03:02:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:02:21 INFO - Running setup.py install for mozcrash 03:02:21 INFO - Running setup.py install for mozdebug 03:02:22 INFO - Running setup.py install for mozdevice 03:02:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Running setup.py install for mozfile 03:02:22 INFO - Running setup.py install for mozhttpd 03:02:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Running setup.py install for mozinfo 03:02:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Running setup.py install for mozInstall 03:02:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Running setup.py install for mozleak 03:02:22 INFO - Running setup.py install for mozlog 03:02:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Running setup.py install for moznetwork 03:02:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:02:22 INFO - Running setup.py install for mozprocess 03:02:22 INFO - Running setup.py install for mozprofile 03:02:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:02:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:02:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:02:23 INFO - Running setup.py install for mozrunner 03:02:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:02:23 INFO - Running setup.py install for mozscreenshot 03:02:23 INFO - Running setup.py install for moztest 03:02:23 INFO - Running setup.py install for mozversion 03:02:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:02:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:02:23 INFO - Cleaning up... 03:02:23 INFO - Return code: 0 03:02:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02: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')]} 03:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:23 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 0x1a8e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfbeb0>, '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 0x1dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfd240>, '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': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:02:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:02:23 INFO - Using env: {'DISPLAY': ':0', 03:02:23 INFO - 'HOME': '/home/cltbld', 03:02:23 INFO - 'LANG': 'en_US.UTF-8', 03:02:23 INFO - 'LANGUAGE': 'en_US:en', 03:02:23 INFO - 'LOGNAME': 'cltbld', 03:02:23 INFO - 'MAIL': '/var/mail/cltbld', 03:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:23 INFO - 'MOZ_NO_REMOTE': '1', 03:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:23 INFO - 'NO_EM_RESTART': '1', 03:02:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:23 INFO - 'PWD': '/builds/slave/test', 03:02:23 INFO - 'SHELL': '/bin/bash', 03:02:23 INFO - 'SHLVL': '1', 03:02:23 INFO - 'TERM': 'linux', 03:02:23 INFO - 'TMOUT': '86400', 03:02:23 INFO - 'USER': 'cltbld', 03:02:23 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 03:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:23 INFO - '_': '/tools/buildbot/bin/python'} 03:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:23 INFO - Running setup.py (path:/tmp/pip-04MPj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:23 INFO - Running setup.py (path:/tmp/pip-FORrlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:23 INFO - Running setup.py (path:/tmp/pip-73K8TT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:23 INFO - Running setup.py (path:/tmp/pip-9S7Qmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:24 INFO - Running setup.py (path:/tmp/pip-XirMIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:24 INFO - Running setup.py (path:/tmp/pip-YhhJ0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:24 INFO - Running setup.py (path:/tmp/pip-NrE0_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:24 INFO - Running setup.py (path:/tmp/pip-F6DFPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:24 INFO - Running setup.py (path:/tmp/pip-dxlXTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:24 INFO - Running setup.py (path:/tmp/pip-73oO4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:24 INFO - Running setup.py (path:/tmp/pip-LGDfCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:24 INFO - Running setup.py (path:/tmp/pip-7rUxOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:24 INFO - Running setup.py (path:/tmp/pip-gs_Cic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:24 INFO - Running setup.py (path:/tmp/pip-wqrPVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:24 INFO - Running setup.py (path:/tmp/pip-IScQYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:24 INFO - Running setup.py (path:/tmp/pip-rmMIXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:24 INFO - Running setup.py (path:/tmp/pip-Fi7nru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:02:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:26 INFO - Downloading blessings-1.6.tar.gz 03:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:02:26 INFO - Installing collected packages: blessings 03:02:26 INFO - Running setup.py install for blessings 03:02:26 INFO - Successfully installed blessings 03:02:26 INFO - Cleaning up... 03:02:26 INFO - Return code: 0 03:02:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:02:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:26 INFO - Reading from file tmpfile_stdout 03:02:26 INFO - Current package versions: 03:02:26 INFO - argparse == 1.2.1 03:02:26 INFO - blessings == 1.6 03:02:26 INFO - blobuploader == 1.2.4 03:02:26 INFO - docopt == 0.6.1 03:02:26 INFO - functools32 == 3.2.3-2 03:02:26 INFO - jsonschema == 2.5.1 03:02:26 INFO - manifestparser == 1.1 03:02:26 INFO - mozInstall == 1.13 03:02:26 INFO - mozcrash == 1.0 03:02:26 INFO - mozdebug == 0.1 03:02:26 INFO - mozdevice == 0.51 03:02:26 INFO - mozfile == 1.2 03:02:26 INFO - mozhttpd == 0.7 03:02:26 INFO - mozinfo == 0.10 03:02:26 INFO - mozleak == 0.1 03:02:26 INFO - mozlog == 3.5 03:02:26 INFO - moznetwork == 0.27 03:02:26 INFO - mozprocess == 0.25 03:02:26 INFO - mozprofile == 0.28 03:02:26 INFO - mozrunner == 6.13 03:02:26 INFO - mozscreenshot == 0.1 03:02:26 INFO - mozsystemmonitor == 0.3 03:02:26 INFO - moztest == 0.8 03:02:26 INFO - mozversion == 1.4 03:02:26 INFO - psutil == 3.1.1 03:02:26 INFO - requests == 1.2.3 03:02:26 INFO - wsgiref == 0.1.2 03:02:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02: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')]} 03:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:26 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 0x1a8e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfbeb0>, '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 0x1dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfd240>, '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': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:02:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:02:26 INFO - Using env: {'DISPLAY': ':0', 03:02:26 INFO - 'HOME': '/home/cltbld', 03:02:26 INFO - 'LANG': 'en_US.UTF-8', 03:02:26 INFO - 'LANGUAGE': 'en_US:en', 03:02:26 INFO - 'LOGNAME': 'cltbld', 03:02:26 INFO - 'MAIL': '/var/mail/cltbld', 03:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:26 INFO - 'MOZ_NO_REMOTE': '1', 03:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:26 INFO - 'NO_EM_RESTART': '1', 03:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:26 INFO - 'PWD': '/builds/slave/test', 03:02:26 INFO - 'SHELL': '/bin/bash', 03:02:26 INFO - 'SHLVL': '1', 03:02:26 INFO - 'TERM': 'linux', 03:02:26 INFO - 'TMOUT': '86400', 03:02:26 INFO - 'USER': 'cltbld', 03:02:26 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 03:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:26 INFO - '_': '/tools/buildbot/bin/python'} 03:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:02:26 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:02: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 03:02: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 03:02: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 03:02: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 03:02:27 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:02:27 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:02:28 INFO - Installing collected packages: marionette-driver, simplejson 03:02:28 INFO - Running setup.py install for marionette-driver 03:02:28 INFO - Running setup.py install for simplejson 03:02:28 INFO - building 'simplejson._speedups' extension 03:02:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:02:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:02:29 INFO - Successfully installed marionette-driver simplejson 03:02:29 INFO - Cleaning up... 03:02:29 INFO - Return code: 0 03:02:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c5ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dfed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dfbeb0>, '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 0x1dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfd240>, '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': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:02:29 INFO - Using env: {'DISPLAY': ':0', 03:02:29 INFO - 'HOME': '/home/cltbld', 03:02:29 INFO - 'LANG': 'en_US.UTF-8', 03:02:29 INFO - 'LANGUAGE': 'en_US:en', 03:02:29 INFO - 'LOGNAME': 'cltbld', 03:02:29 INFO - 'MAIL': '/var/mail/cltbld', 03:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:29 INFO - 'MOZ_NO_REMOTE': '1', 03:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:29 INFO - 'NO_EM_RESTART': '1', 03:02:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:29 INFO - 'PWD': '/builds/slave/test', 03:02:29 INFO - 'SHELL': '/bin/bash', 03:02:29 INFO - 'SHLVL': '1', 03:02:29 INFO - 'TERM': 'linux', 03:02:29 INFO - 'TMOUT': '86400', 03:02:29 INFO - 'USER': 'cltbld', 03:02:29 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 03:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:29 INFO - '_': '/tools/buildbot/bin/python'} 03:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:02:29 INFO - Cleaning up... 03:02:29 INFO - Return code: 0 03:02:29 INFO - Running post-action listener: _resource_record_post_action 03:02:29 INFO - Running post-action listener: _start_resource_monitoring 03:02:29 INFO - Starting resource monitoring. 03:02:29 INFO - [mozharness: 2017-07-30 10:02:29.560564Z] Finished create-virtualenv step (success) 03:02:29 INFO - [mozharness: 2017-07-30 10:02:29.561598Z] Running install step. 03:02:29 INFO - Running pre-action listener: _resource_record_pre_action 03:02:29 INFO - Running main action method: install 03:02:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:29 INFO - Reading from file tmpfile_stdout 03:02:29 INFO - Detecting whether we're running mozinstall >=1.0... 03:02:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:02:29 INFO - Reading from file tmpfile_stdout 03:02:29 INFO - Output received: 03:02:29 INFO - Usage: mozinstall [options] installer 03:02:29 INFO - Options: 03:02:29 INFO - -h, --help show this help message and exit 03:02:29 INFO - -d DEST, --destination=DEST 03:02:29 INFO - Directory to install application into. [default: 03:02:29 INFO - "/builds/slave/test"] 03:02:29 INFO - --app=APP Application being installed. [default: firefox] 03:02:29 INFO - mkdir: /builds/slave/test/build/application 03:02:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:02:47 INFO - Reading from file tmpfile_stdout 03:02:47 INFO - Output received: 03:02:47 INFO - /builds/slave/test/build/application/firefox/firefox 03:02:47 INFO - Running post-action listener: _resource_record_post_action 03:02:47 INFO - [mozharness: 2017-07-30 10:02:47.956761Z] Finished install step (success) 03:02:47 INFO - [mozharness: 2017-07-30 10:02:47.956909Z] Running setup-mitmproxy step. 03:02:47 INFO - Running pre-action listener: _resource_record_pre_action 03:02:47 INFO - Running main action method: setup_mitmproxy 03:02:47 INFO - Skipping: mitmproxy is not required 03:02:47 INFO - Running post-action listener: _resource_record_post_action 03:02:47 INFO - [mozharness: 2017-07-30 10:02:47.957600Z] Finished setup-mitmproxy step (success) 03:02:47 INFO - [mozharness: 2017-07-30 10:02:47.957825Z] Running run-tests step. 03:02:47 INFO - Running pre-action listener: _resource_record_pre_action 03:02:47 INFO - Running pre-action listener: _set_gcov_prefix 03:02:47 INFO - Running main action method: run_tests 03:02:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:02:47 INFO - Python 2.7.3 03:02:47 INFO - Return code: 0 03:02:47 INFO - grabbing minidump binary from tooltool 03:02:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:47 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 0x1dfbeb0>, '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 0x1dfcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dfd240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:02:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:02:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:02:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:02:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:02:48 INFO - Return code: 0 03:02:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:02:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:02:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:02:48 INFO - ENV: RUST_BACKTRACE is now 1 03:02:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:02:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:02:48 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/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:02:48 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/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:02:48 INFO - Using env: {'DISPLAY': ':0', 03:02:48 INFO - 'HOME': '/home/cltbld', 03:02:48 INFO - 'LANG': 'en_US.UTF-8', 03:02:48 INFO - 'LANGUAGE': 'en_US:en', 03:02:48 INFO - 'LOGNAME': 'cltbld', 03:02:48 INFO - 'MAIL': '/var/mail/cltbld', 03:02:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:02:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:48 INFO - 'MOZ_NO_REMOTE': '1', 03:02:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:48 INFO - 'NO_EM_RESTART': '1', 03:02:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:48 INFO - 'PWD': '/builds/slave/test', 03:02:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:02:48 INFO - 'RUST_BACKTRACE': '1', 03:02:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:02:48 INFO - 'SHELL': '/bin/bash', 03:02:48 INFO - 'SHLVL': '1', 03:02:48 INFO - 'TERM': 'linux', 03:02:48 INFO - 'TMOUT': '86400', 03:02:48 INFO - 'USER': 'cltbld', 03:02:48 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208', 03:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:48 INFO - '_': '/tools/buildbot/bin/python'} 03:02:48 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/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:02:48 INFO - mozversion application_buildid: 20170730091350 03:02:48 INFO - mozversion application_changeset: 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f 03:02:48 INFO - mozversion application_display_name: Nightly 03:02:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:02:48 INFO - mozversion application_name: Firefox 03:02:48 INFO - mozversion application_remotingname: firefox 03:02:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:02:48 INFO - mozversion application_vendor: Mozilla 03:02:48 INFO - mozversion application_version: 56.0a1 03:02:48 INFO - mozversion platform_buildid: 20170730091350 03:02:48 INFO - mozversion platform_changeset: 6ee53b46474f74c231b1b569e8f2ecd9d0948a8f 03:02:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:02:48 INFO - mozversion platform_version: 56.0a1 03:02:48 INFO - using testdate: 1501408968 03:02:48 INFO - actual date: 1501408968 03:02:48 INFO - starting webserver on 'localhost:59116' 03:02:48 INFO - SUITE-START | Running 2 tests 03:02:48 INFO - TEST-START | dromaeo_css 03:02:48 INFO - Initialising browser for dromaeo_css test... 03:02:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59116/getInfo.html -profile /tmp/tmpujrzt_/profile 03:02:48 INFO - TEST-INFO | started process 3452 (/builds/slave/test/build/application/firefox/firefox http://localhost:59116/getInfo.html) 03:02:57 INFO - TEST-INFO | 3452: exit 0 03:02:57 INFO - Browser initialized. 03:02:57 INFO - Running cycle 1/1 for dromaeo_css test... 03:02:57 INFO - TEST-INFO | started process 3661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpujrzt_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:02:58 INFO - PID 3661 | 03:02:58 INFO - PID 3661 | (/builds/slave/test/build/application/firefox/firefox:3709): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:02:58 INFO - PID 3661 | 03:03:08 INFO - PID 3661 | RSS: Main: 171597824 03:03:08 INFO - PID 3661 | 03:06:08 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:59116/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59116/tests/dromaeo/cssquery-ext.html) 03:06:09 INFO - PID 3661 | RSS: Main: 172883968 03:06:09 INFO - PID 3661 | 03:09:11 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:59116/tests/dromaeo/cssquery-ext.html (next: http://localhost:59116/tests/dromaeo/cssquery-jquery.html) 03:09:12 INFO - PID 3661 | RSS: Main: 170426368 03:09:12 INFO - PID 3661 | 03:12:13 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:59116/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59116/tests/dromaeo/cssquery-mootools.html) 03:12:14 INFO - PID 3661 | RSS: Main: 170962944 03:12:14 INFO - PID 3661 | 03:15:16 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:59116/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59116/tests/dromaeo/cssquery-prototype.html) 03:15:16 INFO - PID 3661 | RSS: Main: 170905600 03:15:16 INFO - PID 3661 | 03:18:20 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:59116/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59116/tests/dromaeo/cssquery-yui.html) 03:18:21 INFO - PID 3661 | RSS: Main: 174362624 03:18:21 INFO - PID 3661 | 03:21:23 INFO - PID 3661 | Cycle 1(1): loaded http://localhost:59116/tests/dromaeo/cssquery-yui.html (next: http://localhost:59116/tests/dromaeo/cssquery-dojo.html) 03:21:23 INFO - PID 3661 | RSS: Main: 175517696 03:21:23 INFO - PID 3661 | 03:21:23 INFO - PID 3661 | __start_tp_report 03:21:23 INFO - PID 3661 | _x_x_mozilla_page_load 03:21:23 INFO - PID 3661 | _x_x_mozilla_page_load_details 03:21:23 INFO - PID 3661 | |i|pagename|runs| 03:21:23 INFO - PID 3661 | |0;dojo.html;3156.5265210218463;3190.0908241151274;3191.1543440988125;3204.0227730542183;3248.8538015789286;6044.818655440333;6116.969415152924;6152;6163.784267550636;6172;6006.579539432241;6095.177151084602;6096.878062438748;6099.115628233903;6137.754489820413;5640.915386269209;5650.943490565083;5665.575081868856;5682.602217844753;5751.65490070595;5663.971680141593;5700.401457846929;5756;5781.364049954502;5794.5074668653215;5410.458954104558;5585.8603534911545;5590.8602284943;5661.122526008476;5664.40523745007;5119.1553393690365;5545.417731138253;5550.000999820031;5604.215409842625;5616.971915140439;5518.668879867221;5524.254225679522;5575.275214222166;5594.748236329334;5620.9437905621235;5974.6713930733795;6031.336552979169;6085.148079268906;6104.236970378703;6118.4799292060225;6656.234533028715;6659.40065394112;6685.832854178636;6747;6751.493637977172;6717.798466046026;6727.159105111861;6801.863962720768;6807.591544507345;6824.488163387766;6120.112583675342;6217.067439884008;6227.937720622826;6289.968550157311;6312.210973628296;6780.932190678129;6815.454763618898;6815.522913396114;6816.693248803816;6823.1812182538415;6429.164208652845;6486.837829054217;6493.545451818327;6498.220213574401;6501.252355979028;6615.669216539154;6622.668866556653;6632.734690612418;6634.900476492857;6642.036904648799;6594.07682924391;6613.669316534154;6618;6618.96690516554;6622.072909792633;6622.569532980341;6659.9001014984815;6740.4270636995425;6762.222344430454;6768.221654509696;5327.893442131136;5397.730113494388;5407.729613519308;5409.107497262908;5415.783368665288;4542.136993971135;4567.954320456753;4570.223062079388;4616.884577885579;4638.257878739386;5765.365809760923;5797;5800.39095894925;5803.100519419497;5803.767849285981;6595.670216489157;6650.600963942082;6657.367550082734;6680.96659516709;6685.6322902240845;5779.826605201851;5789.594728369058;5792;5809.099589563624;5871.178035075093;5821.330546987066;5918;5929.970350148308;5930.55520835939;5941.70291485424;6363.7772677956045;6456.3543645636;6487.870242595121;6564.9671751640935;6565.934340656532;6597.406233439014;6696.899546506709;6700.329967003261;6722.462203023649;6722.9663851680425;6388;6458.160439143069;6502.934970650422;6503.154589903283;6581.736730530725;6625.105610742488;6644.501662375244;6712.39588437043;6716;6728.899066513908;6595.505337099833;6679.699413526306;6680.3987641112535;6732.697028633625;6840.965795170992;6440.162778838721;6447.838804029937;6457.644829534421;6476.740930362921;6587.242467116152;6461.64460954652;6531.771388001587;6532.542722009413;6534.444572211415;6555.704993275219;6495.317991610813;6510.44661203803;6516.641584712696;6528.543001989815;6535.183102112236;6522.445592124723;6537.542372034102;6551.80344589663;6624.0395142705;6645.036469711961;6162.568620196544;6239.876822172053;6247.687615619292;6267.62394256346;6420.6147631142285 03:21:23 INFO - PID 3661 | |1;ext.html;810.5703976892249;811.9878201826974;847.9618417171229;870.2515836380716;875.8029443375241;42212.36681449781;42917;42991.35512967308;43046.56953430469;43052;39269.41095883564;39590;39635.80182099093;39666.603333966654;39753.20493590134;7018.5788852668875;7152.570845749272;7159.57042577447;7162.355388015078;7163.964180179092;7019.333163349474;7117.537360071605;7122.501424900259;7126.8574628507395;7130.572165670076;7042.929570704304;7067.151941766995;7069.5758254504635;7069.929300706978;7081.185663648669;7023.9999999999745;7042.894356584656;7076.469264805109;7081.858362832741;7083;6382.329855365213;6440.130582371414;6444.613323200623;6446.580972236837;6450.387213214737;34818.82590587056;35112.47331290033;35121.82439087814;35166.64833351659;35206.647933520595;3375.6118046424485;3422.2128910350757;3426.6573342665783;3428.8457019434186;3431.1422144463886;27712.168634940983;27752.583711244348;27753.861230693918;27804.30489237765;27848.443031139468;4296.720713153666;4302.634276086536;4352.956470435319;4361.672874534423;4362.214801335758;177999;179708;179873;182848;195080.99999999857;50275.74862125739;50515.7474212634;50541.74729126331;50549;50562.241566376535;52833;52952.47047529552;53013.734931325096;53028.46971530312;53070;15979.920100399657;16167.676646467005;16173.353065877469;16209.108499032667;16448.671026579403;13470.461181552824;13484.932575337256;13486.797698034341;13497.460101596023;13501.122427042212;14074.085184463182;14173.291335433187;14203.218822964836;14216.573502794932;14396.712065758626;5447.972760136174;5448.291722076105;5517.69652669107;5531.419200983919;5555.2778138841695;972.4214092614883;983.1348413396165;1012.3419777144915;1021.5709402051008;1022.5858527296457;22844.543109137725;23104.884475577852;23268.53462930732;28734.856325718236;29918.952836650613;1059.2161800267747;1089.9128069754559;1092;1101.6089288302696;1107.9390633515234;12370.876291237153;12663.353764010619;12667.176633518791;12712.364381780873;12781.041421893395;217372;217422;217727;218490;218654;54265.45734542604;54281.72859135679;54389;54391;54503.45496544984;1448.167303800298;1450.8476609955803;1480.4966311454157;1491.8806495480335;1501.1068414293477;21949;22225.546961105723;22416.551668966204;22841.771582283964;23072.884635576716;50268.74865625649;52740.47259527355;53075.73462132664;53396.46603533915;53883.19175212296;197338;197343;197584;198282;198721;30685.693143069177;31097.68902310948;31170.376592468478;32065;34926.65073349234;40486.19027619372;45745.31382029339;46001;46823;46883.53116468792;31848.203794905312;32617.836910815295;32652.673473264964;32684;32845.178870527474;30725.846370768897;31518.684813151576;32656.34687306288;32987.17532061718;33047.66952330446;36568.817155914054;36683.63316366802;36714;37039.8148009269;37093.62906370902;31876.36247275088;32673.509897352033;32972;33015.33969320648;33084.834575826964;23485.765142349042;23591.41021474477;23898.761012389652;23997.16009939644;24383.26850194497 03:21:23 INFO - PID 3661 | |2;jquery.html;564.2016546586583;571.3486625247216;582.3142003898713;589.9056151015837;590.1148277583624;22159.778402215972;22905;22980.425489362773;23008.8849555752;23039;25687.743122568816;26727.866360668217;28023.579646305323;28111.437771244564;28189.57715634267;7165.355118039375;7338.889916651227;7340.119185697724;7343.302386273295;7348.963255183717;7263.673134708924;7294.240994533075;7326.81682957925;7337.633118344062;7337.706491740324;6706.832329191785;7169.713211471535;7190.496665233436;7204.567725936435;7212;7129.7861064168155;7186.02988596538;7195.676194571257;7204.747833825791;7210.4952653314285;7013.929860701379;7032.296770322978;7033.8944915826305;7049.89425158623;7055.259197784261;29439.558406623917;30219.395612087854;30625.928092516657;30675.38649227003;31474.685253147403;1930.5463216144194;1966.7246585478044;1978.5053736565858;1981.4947188466992;1984.2162345873298;20239.696404553943;20653.17387304506;20776.857272849986;20890;21028.158873645036;2385.141349114335;2409.506051259488;2490.7297278387973;2505.1983365323103;2508.0344067533947;138046.6195338044;139566;143508;143614;144044.27977860044;20478.692819607717;21781.23765668194;23490.530189396457;23583.528329433317;24235.151769687975;44074.77962610166;44348;44504.10991780146;44551.55448445474;44621.33068003983;11700.765984680258;11717.12121590884;11754.177207595558;11780.646580602595;12074.335911524775;9621.615135394646;9727.173190278905;9759;9862.50687465624;9911.454869982075;8701.912980870236;9303.767405814773;11446.542138314375;11687.707807304885;11689.532418703157;2727.345437095083;2767.2113447667316;2818.5208514552573;2845.9430811384073;2846.9361354906696;945.5130607737021;946.8153710026479;966.2025683492533;985.930984831055;993.8956409577034;18678.252869885324;19402.4179274622;23390.883045585004;24932.626010609856;25341.74658253394;1015.2537884654773;1023.1967905194387;1026.9897301026895;1052.321252791945;1054.319963623474;10947.50736216872;11006.339619622848;11242.943785281184;11348.54605815758;11355;486879;487220;493432;529150;531624;122081;122140.38929805293;123357.38321308515;123999.3800030994;125736;1225.197495640357;1268.6447794617523;1293.359193869255;1309.2340980526308;1314.6581888708813;19747.802521974598;20073.29743458972;20580.176792928116;21225;21638.35084947454;56524.71737641285;57244.71377643085;57564;57604.1359379618;58580;65613;66845.66577167083;67677.3232267671;67681.3231867675;67850.66074669595;12467.877890989854;14652.560423187322;15003.324850381978;15019.399224031353;15030.924845375703;22753.544929101656;24287.878560607085;24324;24338.87830560836;24453.144139955017;18311.084445777924;18598.721019184995;18988;19214.423567293004;19337.70993435128;16378.313733306377;16489.422870199487;16805.41181058657;17542.12289385551;17726.822731772518;18830.811691883453;19689.901550492155;20188.495287617927;20209.898950505154;20212.696809547575;14859.182744949132;14869.18219497938;15109.54671359861;15122.319495622503;15124.39502419891;18174;18571.25714971386;18925.440239790183;19090.14094365729;19233 03:21:23 INFO - PID 3661 | |3;mootools.html;1355.4781409157472;1402.661665236736;1408.9225092619902;1419.1626940105348;1427.2150317325475;12137;13432.126911750729;14011.579652610413;14114.505992290258;14127.57617271481;12101.394930253475;13305.667358316046;14189.92905035476;14211.360488778004;14230.075045122087;2622.3313055170906;2667.2531691126514;2670.626112344273;2671.7728993035616;2691.825031372964;2545.783608393289;2636.6045093235975;2645.193216069098;2665.6934452537917;2725.645666063419;2643.2730998975244;2686.6641669791275;2688.0323083689855;2688.8117831751783;2689.4217743185213;2607.4785042991384;2637.5648018076995;2642.563976943802;2648.827826191301;2660.2950218192195;2610.6345111684377;2617.5811870100883;2634.4204275059647;2654.7876169906363;2656.296081538394;13781.724365512733;13845.723085538333;13895.305234738324;13903.513377031857;13951.162930224218;7579.393648508106;7814.257645523666;7846.764597062097;7862.52824830512;7870.921290787133;5193.1171700810955;5211.973940130275;5367.973160134175;5427.864303392407;5519.39286678465;1830.588117673526;1840.089155867854;1860.0885566072661;1872.5505878589177;1882.491727233653;22426.32721018372;22975.425614359607;22975.54048919029;22989.655155172684;22990.770092299197;6741.1236539249585;6829.453643708492;6850.623215723183;7050.858982820315;7070.434365250768;18499;18556.907215463838;18558;18564.97892615919;18565;7530.43521735872;7687.692492300357;7689.4232932530285;7693.1922148173635;7694.461387702919;6779.864402711918;6871.518993670495;6900.378965893094;6906.06768086312;6945.201301850251;5318.840434786963;5482.972585137049;5488.231647569343;5491.945080549223;5520.089185284383;1532.5938626264049;1558.8752899767992;1626.2844348486628;1683.4781217822515;1728.3518680494815;803.9075506316849;808.6078252047752;823.4236034775561;825.0099880143852;834.7495751274594;7260.128784545888;7375.262473752582;7695.4997925134685;7752.534847909031;7755.72854950074;908.246155690775;912.115248209236;943.5801068524578;969.0842154164388;985.2265971212564;4391.8682439526865;4797.832075877328;4815.470298267188;4867.610591152699;4966.6771659842;17738.91130544365;18695.15871785773;18726.719099213522;18732.25070997145;18760.24959001652;17842;19074.904625476785;19145.904270478557;19154.904225479062;19182.616347672967;10059.346142500714;10207.846882296772;10269.691909242734;10285.640002600023;10338.586456541805;7290.817729556804;7763.573003484863;7915.208479152038;8017.799555011172;8029.277365037175;16212.10833404174;16361.754573681166;16422.67154656924;17005.064721439943;17080.82919170842;16324.836751632807;16833.579160521083;16952;17008.65982680315;17352.219150138022;10825.458727063773;11360.943195283971;11380.43097845121;11571.132165087483;11590.652280431601;13000.414981325674;13082.542111026069;13121.015923805944;13126.474941002252;13139.277339746406;9973.102420781874;10098.343607665773;10150.340227885164;10266.127379172854;10454.372737635766;9980.700578982642;10236.89799410114;10414.323069000491;10530.210234232616;10809.297395669257;8489.108643592333;8649.437786543855;8658.870116948125;8673.262772664142;8680.739577812676;5873.119032145212;6119.663418511846;6360.586561873463;6362.236531616236;6430.453411460078;6332.588381755171;6418.326075762165;6435.581687190505;6512.381323774234;6551.21385433751 03:21:23 INFO - PID 3661 | |4;prototype.html;495.99370546140847;504.17237514011686;518.3520599250936;524.824183898394;525.1571228178773;6174.9382506174925;6185.752569897204;6200.720967556459;6269.404406581379;6294.779682711106;5907;6118.235220597414;6142.201513803199;6146.293176284728;6147.969260153704;4865.002674451729;4911.557959783619;4924.187509061001;4957.356343087837;4994.076095922266;4786.234202527597;4948.1093403187415;4953.1332016896895;5008.348914641091;5013.749312534377;4852.757362131879;4867.979788387815;4894.36373271476;4896.951030489685;4947.802087916479;4828.879278018043;4869.293952376903;4885.2427873679635;4906.141425250585;4952.479989601076;4387.3857659927635;4447.977760111211;4468.642508599337;4495.303227999665;4501.527339629324;6014.827108713803;6028.909566356509;6043.758249670008;6074.815410994858;6086.573939824169;5602.971985140048;5666;5666.575006874501;5678.545716342683;5683.119116536944;6463.57986730861;6495.805125846185;6557.672116394161;6569.474442044625;6597.505187110938;4857.781399837016;4876.829310974134;4886.267059941002;4905.4358748744;4914.311996320518;6806.727730890759;6881;6935.6878940448305;6954.582725036514;6999;4931.276885951155;4948.505149485023;4962.429320628102;5005.82479613219;5007.499250074963;5046.7476626168545;5048.359283232964;5060.468650791688;5078.542931136216;5130.589552835764;5622.578306626938;5669.688167150764;5714.7428365723645;5736.881308144955;5739.569532285095;6506.284308726036;6508.544401891822;6573.80278591643;6575.178102737158;6623.602583844985;1653.2147230065864;1705.2667353038064;1711.5464401933498;1714.485654303704;1741.5733145379463;1202.1765090912752;1209.9395030248452;1228.6252692928742;1232.6502479784622;1236.9567065152676;5745.13822926556;5766.654000759968;5767.798127065533;5772.855678607984;5801.042827933428;6514.902276465857;6520.576162549514;6579.572327798678;6615.140031795836;6702.731890724414;5710.685912274782;5764.481196692318;5776.364599894008;5839.240898683144;5852.561057920673;3579.677828995351;3592.6946209571956;3595.442706380515;3612.4581312802766;3615.6022837487853;6514.869702605922;6526.184226971629;6546;6577.375149360803;6586.4072233498255;6848.554843935129;6873.347032031949;6913.688884000232;6960.721571137199;6961.477889158334;6505.779639078686;6514.54398192122;6516.609003459807;6564.573302735307;6565.507586930999;6676.198856137295;6689.096971908924;6695.665216739046;6749.4600431964345;6750;6678.899816502659;6695.732170713117;6699.363560461748;6711.127553418024;6719.462443004646;6493.707783149675;6513.641749703812;6514.3811337922825;6532.444742196966;6568.6058836468055;4980.701157930535;5000.974995125001;5001.649884508195;5020.723860187724;5026.52248036436;6676.798176328308;6689.364510371507;6698.330166983263;6711.46308295345;6730.596164230162;6390.201224846895;6405.263394709668;6511.186101737283;6524.217093948757;6554;6256.468200203034;6354.568532992317;6546.24718157418;6551.934480655133;6561.572218279076;6025.246844144482;6329.145565348619;6402.775902843378;6453.774117906039;6496.350364963466;6525.804225873231;6529.477641788741;6542.771003014872;6552.901706474502;6560.475161986934;6340.809775706736;6346.904796427965;6356.4279214870885;6358.459530939922;6380.138681278154 03:21:23 INFO - PID 3661 | |5;yui.html;904.769283832623;915.199200699388;923.2291036984118;924.1220840201805;925.6852670092168;18477.35329263476;19362.225510979544;19364.419067427963;19372.128254228577;19404.320848770294;19706.901465492687;20584;21383.14467421305;21723.565528689418;21906.23328183514;1012.4380968562444;1037.590151890003;1037.8131936251473;1038.1124138861278;1038.231708535682;992.3748038735622;1048.2505008918622;1050.7845891592206;1051.5005372448102;1051.55834549489;1100.0099910080912;1101.372217835834;1102.2119184782878;1102.2284400919348;1103.1340397787737;1089.8637670291214;1090.2095980414215;1090.869095708512;1091.683411810574;1097.8243481043035;796.8645330293864;800.4756884240832;801.7995501124719;802.1617409806765;808.9231523005305;19222.711659325123;19635.901820490948;19875.0062496876;19938.60122797536;19981.600367992705;20217.191312347488;20571.691424628643;20618.58762824735;20642.27752028687;20805.16779328825;15663.686726265525;15874.444394446138;15882.523524294289;16055;16055.759163612554;3460.3425349183576;3470.5141280220537;3480.843362048714;3485.599156097056;3490;120765;122349;122493;124812.37593812063;128434.3578282112;14745.631359216106;15087.698246035017;15126.848731512764;15127.470538531099;15158.31787569562;27007.72992270052;27258.182254532396;27410.314742131206;27414.45171096567;27585.86207068952;7890.447668663253;8104;8133.349332053422;8447.662093516314;8481.660733570712;3986.5216174059296;4012.4382586437923;4082.3060079786505;4092.324766413568;4106.1582375612925;4760.857174284777;5049.545540901263;5212.739363031909;5494.587905907073;5701.315842098892;1076.155218153761;1095.2278643556274;1115.0967716149944;1116.385987706758;1120.2662256222188;626.8871603111393;665.8701553197177;674.3256743256743;686.3685409423342;687.182253118787;11528.827067593993;11757.470913808898;12121.818172727417;12448.25310481374;12869.4208760606;618.1747367264752;644.7227692092446;649.5647915896361;661.0579923608839;669.4276393683427;5246.947530524722;5299.549538289211;5385.272988146628;5389.568834493231;5506.972465137648;99863;100914.49542752239;102848;103882;104917;86370.56814715886;91594;92822.53588732013;93202.53398732963;96554.51722741482;80579.01669830561;82335.588322058;84366;85541.57229213814;86274;10361.792764144826;10450.594464981577;10639.627613033506;10752;10918.01737843598;36970.63029369672;38878.805605971786;39137.41293880537;39362;39381.409278860265;45459;48105;48423.27365089456;48677.02645947132;50152;14750.336234869243;14991.400343986556;15068.171250581323;15149.62125946816;15162.924185379003;16102.758458622895;17089.230984605972;17267.65464690674;17542.561435964202;20343.79656203419;17687.292508300037;18515.259389624804;19028.714569281194;19577.314793982143;19723.112459939624;19406.126724297723;19609.509762256057;19611.215551377783;19688.31090911811;20013.39959801208;17261.482155535356;17280.654386912443;17323.82676173222;18412.539686507407;19099.61800764005;12831.871681283068;13211.801822972855;13495.325233738471;13698.726025479635;13717.931410342884;13025.283609401575;14355.354009069408;14616.41534338657;14673.192974386511;14749.852501474848 03:21:23 INFO - PID 3661 | __end_tp_report 03:21:23 INFO - PID 3661 | __start_cc_report 03:21:23 INFO - PID 3661 | _x_x_mozilla_cycle_collect,384 03:21:23 INFO - PID 3661 | __end_cc_report 03:21:23 INFO - PID 3661 | __startTimestamp1501410083324__endTimestamp 03:21:23 INFO - PID 3661 | 03:21:23 INFO - PID 3661 | ------- Summary: start ------- 03:21:23 INFO - PID 3661 | Number of tests: 6 03:21:23 INFO - PID 3661 | 03:21:23 INFO - PID 3661 | [#0] dojo.html Cycles:165 Average:6122.74 Median:6429.16 stddev:732.02 (11.4%) stddev-sans-first:696.30 03:21:23 INFO - PID 3661 | Values: 3156.5 3190.1 3191.2 3204.0 3248.9 6044.8 6117.0 6152.0 6163.8 6172.0 6006.6 6095.2 6096.9 6099.1 6137.8 5640.9 5650.9 5665.6 5682.6 5751.7 5664.0 5700.4 5756.0 5781.4 5794.5 5410.5 5585.9 5590.9 5661.1 5664.4 5119.2 5545.4 5550.0 5604.2 5617.0 5518.7 5524.3 5575.3 5594.7 5620.9 5974.7 6031.3 6085.1 6104.2 6118.5 6656.2 6659.4 6685.8 6747.0 6751.5 6717.8 6727.2 6801.9 6807.6 6824.5 6120.1 6217.1 6227.9 6290.0 6312.2 6780.9 6815.5 6815.5 6816.7 6823.2 6429.2 6486.8 6493.5 6498.2 6501.3 6615.7 6622.7 6632.7 6634.9 6642.0 6594.1 6613.7 6618.0 6619.0 6622.1 6622.6 6659.9 6740.4 6762.2 6768.2 5327.9 5397.7 5407.7 5409.1 5415.8 4542.1 4568.0 4570.2 4616.9 4638.3 5765.4 5797.0 5800.4 5803.1 5803.8 6595.7 6650.6 6657.4 6681.0 6685.6 5779.8 5789.6 5792.0 5809.1 5871.2 5821.3 5918.0 5930.0 5930.6 5941.7 6363.8 6456.4 6487.9 6565.0 6565.9 6597.4 6696.9 6700.3 6722.5 6723.0 6388.0 6458.2 6502.9 6503.2 6581.7 6625.1 6644.5 6712.4 6716.0 6728.9 6595.5 6679.7 6680.4 6732.7 6841.0 6440.2 6447.8 6457.6 6476.7 6587.2 6461.6 6531.8 6532.5 6534.4 6555.7 6495.3 6510.4 6516.6 6528.5 6535.2 6522.4 6537.5 6551.8 6624.0 6645.0 6162.6 6239.9 6247.7 6267.6 6420.6 03:21:23 INFO - PID 3661 | 03:21:23 INFO - PID 3661 | [#1] ext.html Cycles:180 Average:37418.35 Median:3429.99 stddev:51983.96 (1515.6%) stddev-sans-first:52057.11 03:21:23 INFO - PID 3661 | Values: 810.6 812.0 848.0 870.3 875.8 42212.4 42917.0 42991.4 43046.6 43052.0 39269.4 39590.0 39635.8 39666.6 39753.2 7018.6 7152.6 7159.6 7162.4 7164.0 7019.3 7117.5 7122.5 7126.9 7130.6 7042.9 7067.2 7069.6 7069.9 7081.2 7024.0 7042.9 7076.5 7081.9 7083.0 6382.3 6440.1 6444.6 6446.6 6450.4 34818.8 35112.5 35121.8 35166.6 35206.6 3375.6 3422.2 3426.7 3428.8 3431.1 27712.2 27752.6 27753.9 27804.3 27848.4 4296.7 4302.6 4353.0 4361.7 4362.2 177999.0 179708.0 179873.0 182848.0 195081.0 50275.7 50515.7 50541.7 50549.0 50562.2 52833.0 52952.5 53013.7 53028.5 53070.0 15979.9 16167.7 16173.4 16209.1 16448.7 13470.5 13484.9 13486.8 13497.5 13501.1 14074.1 14173.3 14203.2 14216.6 14396.7 5448.0 5448.3 5517.7 5531.4 5555.3 972.4 983.1 1012.3 1021.6 1022.6 22844.5 23104.9 23268.5 28734.9 29919.0 1059.2 1089.9 1092.0 1101.6 1107.9 12370.9 12663.4 12667.2 12712.4 12781.0 217372.0 217422.0 217727.0 218490.0 218654.0 54265.5 54281.7 54389.0 54391.0 54503.5 1448.2 1450.8 1480.5 1491.9 1501.1 21949.0 22225.5 22416.6 22841.8 23072.9 50268.7 52740.5 53075.7 53396.5 53883.2 197338.0 197343.0 197584.0 198282.0 198721.0 30685.7 31097.7 31170.4 32065.0 34926.7 40486.2 45745.3 46001.0 46823.0 46883.5 31848.2 32617.8 32652.7 32684.0 32845.2 30725.8 31518.7 32656.3 32987.2 33047.7 36568.8 36683.6 36714.0 37039.8 37093.6 31876.4 32673.5 32972.0 33015.3 33084.8 23485.8 23591.4 23898.8 23997.2 24383.3 03:21:23 INFO - PID 3661 | 03:21:23 INFO - PID 3661 | [#2] jquery.html Cycles:180 Average:36815.83 Median:12984.33 stddev:85169.19 (655.9%) stddev-sans-first:85364.62 03:21:23 INFO - PID 3661 | Values: 564.2 571.3 582.3 589.9 590.1 22159.8 22905.0 22980.4 23008.9 23039.0 25687.7 26727.9 28023.6 28111.4 28189.6 7165.4 7338.9 7340.1 7343.3 7349.0 7263.7 7294.2 7326.8 7337.6 7337.7 6706.8 7169.7 7190.5 7204.6 7212.0 7129.8 7186.0 7195.7 7204.7 7210.5 7013.9 7032.3 7033.9 7049.9 7055.3 29439.6 30219.4 30625.9 30675.4 31474.7 1930.5 1966.7 1978.5 1981.5 1984.2 20239.7 20653.2 20776.9 20890.0 21028.2 2385.1 2409.5 2490.7 2505.2 2508.0 138046.6 139566.0 143508.0 143614.0 144044.3 20478.7 21781.2 23490.5 23583.5 24235.2 44074.8 44348.0 44504.1 44551.6 44621.3 11700.8 11717.1 11754.2 11780.6 12074.3 9621.6 9727.2 9759.0 9862.5 9911.5 8701.9 9303.8 11446.5 11687.7 11689.5 2727.3 2767.2 2818.5 2845.9 2846.9 945.5 946.8 966.2 985.9 993.9 18678.3 19402.4 23390.9 24932.6 25341.7 1015.3 1023.2 1027.0 1052.3 1054.3 10947.5 11006.3 11242.9 11348.5 11355.0 486879.0 487220.0 493432.0 529150.0 531624.0 122081.0 122140.4 123357.4 123999.4 125736.0 1225.2 1268.6 1293.4 1309.2 1314.7 19747.8 20073.3 20580.2 21225.0 21638.4 56524.7 57244.7 57564.0 57604.1 58580.0 65613.0 66845.7 67677.3 67681.3 67850.7 12467.9 14652.6 15003.3 15019.4 15030.9 22753.5 24287.9 24324.0 24338.9 24453.1 18311.1 18598.7 18988.0 19214.4 19337.7 16378.3 16489.4 16805.4 17542.1 17726.8 18830.8 19689.9 20188.5 20209.9 20212.7 14859.2 14869.2 15109.5 15122.3 15124.4 18174.0 18571.3 18925.4 19090.1 19233.0 03:21:23 INFO - PID 3661 | 03:21:23 INFO - PID 3661 | [#3] mootools.html Cycles:180 Average:8612.52 Median:2640.06 stddev:5914.98 (224.0%) stddev-sans-first:5906.44 03:21:23 INFO - PID 3661 | Values: 1355.5 1402.7 1408.9 1419.2 1427.2 12137.0 13432.1 14011.6 14114.5 14127.6 12101.4 13305.7 14189.9 14211.4 14230.1 2622.3 2667.3 2670.6 2671.8 2691.8 2545.8 2636.6 2645.2 2665.7 2725.6 2643.3 2686.7 2688.0 2688.8 2689.4 2607.5 2637.6 2642.6 2648.8 2660.3 2610.6 2617.6 2634.4 2654.8 2656.3 13781.7 13845.7 13895.3 13903.5 13951.2 7579.4 7814.3 7846.8 7862.5 7870.9 5193.1 5212.0 5368.0 5427.9 5519.4 1830.6 1840.1 1860.1 1872.6 1882.5 22426.3 22975.4 22975.5 22989.7 22990.8 6741.1 6829.5 6850.6 7050.9 7070.4 18499.0 18556.9 18558.0 18565.0 18565.0 7530.4 7687.7 7689.4 7693.2 7694.5 6779.9 6871.5 6900.4 6906.1 6945.2 5318.8 5483.0 5488.2 5491.9 5520.1 1532.6 1558.9 1626.3 1683.5 1728.4 803.9 808.6 823.4 825.0 834.7 7260.1 7375.3 7695.5 7752.5 7755.7 908.2 912.1 943.6 969.1 985.2 4391.9 4797.8 4815.5 4867.6 4966.7 17738.9 18695.2 18726.7 18732.3 18760.2 17842.0 19074.9 19145.9 19154.9 19182.6 10059.3 10207.8 10269.7 10285.6 10338.6 7290.8 7763.6 7915.2 8017.8 8029.3 16212.1 16361.8 16422.7 17005.1 17080.8 16324.8 16833.6 16952.0 17008.7 17352.2 10825.5 11360.9 11380.4 11571.1 11590.7 13000.4 13082.5 13121.0 13126.5 13139.3 9973.1 10098.3 10150.3 10266.1 10454.4 9980.7 10236.9 10414.3 10530.2 10809.3 8489.1 8649.4 8658.9 8673.3 8680.7 5873.1 6119.7 6360.6 6362.2 6430.5 6332.6 6418.3 6435.6 6512.4 6551.2 03:21:23 INFO - PID 3661 | 03:21:23 INFO - PID 3661 | [#4] prototype.html Cycles:180 Average:5493.77 Median:6080.69 stddev:1545.92 (25.4%) stddev-sans-first:1504.05 03:21:23 INFO - PID 3661 | Values: 496.0 504.2 518.4 524.8 525.2 6174.9 6185.8 6200.7 6269.4 6294.8 5907.0 6118.2 6142.2 6146.3 6148.0 4865.0 4911.6 4924.2 4957.4 4994.1 4786.2 4948.1 4953.1 5008.3 5013.7 4852.8 4868.0 4894.4 4897.0 4947.8 4828.9 4869.3 4885.2 4906.1 4952.5 4387.4 4448.0 4468.6 4495.3 4501.5 6014.8 6028.9 6043.8 6074.8 6086.6 5603.0 5666.0 5666.6 5678.5 5683.1 6463.6 6495.8 6557.7 6569.5 6597.5 4857.8 4876.8 4886.3 4905.4 4914.3 6806.7 6881.0 6935.7 6954.6 6999.0 4931.3 4948.5 4962.4 5005.8 5007.5 5046.7 5048.4 5060.5 5078.5 5130.6 5622.6 5669.7 5714.7 5736.9 5739.6 6506.3 6508.5 6573.8 6575.2 6623.6 1653.2 1705.3 1711.5 1714.5 1741.6 1202.2 1209.9 1228.6 1232.7 1237.0 5745.1 5766.7 5767.8 5772.9 5801.0 6514.9 6520.6 6579.6 6615.1 6702.7 5710.7 5764.5 5776.4 5839.2 5852.6 3579.7 3592.7 3595.4 3612.5 3615.6 6514.9 6526.2 6546.0 6577.4 6586.4 6848.6 6873.3 6913.7 6960.7 6961.5 6505.8 6514.5 6516.6 6564.6 6565.5 6676.2 6689.1 6695.7 6749.5 6750.0 6678.9 6695.7 6699.4 6711.1 6719.5 6493.7 6513.6 6514.4 6532.4 6568.6 4980.7 5001.0 5001.6 5020.7 5026.5 6676.8 6689.4 6698.3 6711.5 6730.6 6390.2 6405.3 6511.2 6524.2 6554.0 6256.5 6354.6 6546.2 6551.9 6561.6 6025.2 6329.1 6402.8 6453.8 6496.4 6525.8 6529.5 6542.8 6552.9 6560.5 6340.8 6346.9 6356.4 6358.5 6380.1 03:21:23 INFO - PID 3661 | 03:21:23 INFO - PID 3661 | [#5] yui.html Cycles:180 Average:22285.84 Median:19662.11 stddev:30159.96 (153.4%) stddev-sans-first:30201.83 03:21:23 INFO - PID 3661 | Values: 904.8 915.2 923.2 924.1 925.7 18477.4 19362.2 19364.4 19372.1 19404.3 19706.9 20584.0 21383.1 21723.6 21906.2 1012.4 1037.6 1037.8 1038.1 1038.2 992.4 1048.3 1050.8 1051.5 1051.6 1100.0 1101.4 1102.2 1102.2 1103.1 1089.9 1090.2 1090.9 1091.7 1097.8 796.9 800.5 801.8 802.2 808.9 19222.7 19635.9 19875.0 19938.6 19981.6 20217.2 20571.7 20618.6 20642.3 20805.2 15663.7 15874.4 15882.5 16055.0 16055.8 3460.3 3470.5 3480.8 3485.6 3490.0 120765.0 122349.0 122493.0 124812.4 128434.4 14745.6 15087.7 15126.8 15127.5 15158.3 27007.7 27258.2 27410.3 27414.5 27585.9 7890.4 8104.0 8133.3 8447.7 8481.7 3986.5 4012.4 4082.3 4092.3 4106.2 4760.9 5049.5 5212.7 5494.6 5701.3 1076.2 1095.2 1115.1 1116.4 1120.3 626.9 665.9 674.3 686.4 687.2 11528.8 11757.5 12121.8 12448.3 12869.4 618.2 644.7 649.6 661.1 669.4 5246.9 5299.5 5385.3 5389.6 5507.0 99863.0 100914.5 102848.0 103882.0 104917.0 86370.6 91594.0 92822.5 93202.5 96554.5 80579.0 82335.6 84366.0 85541.6 86274.0 10361.8 10450.6 10639.6 10752.0 10918.0 36970.6 38878.8 39137.4 39362.0 39381.4 45459.0 48105.0 48423.3 48677.0 50152.0 14750.3 14991.4 15068.2 15149.6 15162.9 16102.8 17089.2 17267.7 17542.6 20343.8 17687.3 18515.3 19028.7 19577.3 19723.1 19406.1 19609.5 19611.2 19688.3 20013.4 17261.5 17280.7 17323.8 18412.5 19099.6 12831.9 13211.8 13495.3 13698.7 13717.9 13025.3 14355.4 14616.4 14673.2 14749.9 03:21:23 INFO - PID 3661 | -------- Summary: end -------- 03:21:23 INFO - PID 3661 | 03:21:24 INFO - TEST-INFO | 3661: exit 0 03:21:24 INFO - TEST-OK | dromaeo_css | took 1115455ms 03:21:24 INFO - TEST-START | kraken 03:21:24 INFO - Initialising browser for kraken test... 03:21:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59116/getInfo.html -profile /tmp/tmpuITYUy/profile 03:21:24 INFO - TEST-INFO | started process 4029 (/builds/slave/test/build/application/firefox/firefox http://localhost:59116/getInfo.html) 03:21:30 INFO - TEST-INFO | 4029: exit 0 03:21:30 INFO - Browser initialized. 03:21:30 INFO - Running cycle 1/1 for kraken test... 03:21:30 INFO - TEST-INFO | started process 4238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuITYUy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:21:31 INFO - PID 4238 | 03:21:31 INFO - PID 4238 | (/builds/slave/test/build/application/firefox/firefox:4286): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:21:31 INFO - PID 4238 | 03:21:41 INFO - PID 4238 | RSS: Main: 171266048 03:21:41 INFO - PID 4238 | 03:21:44 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59116/tests/kraken/driver.html?testName=audio-beat-detection) 03:21:45 INFO - PID 4238 | RSS: Main: 178102272 03:21:45 INFO - PID 4238 | 03:21:47 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59116/tests/kraken/driver.html?testName=audio-dft) 03:21:48 INFO - PID 4238 | RSS: Main: 178196480 03:21:48 INFO - PID 4238 | 03:21:51 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59116/tests/kraken/driver.html?testName=audio-fft) 03:21:52 INFO - PID 4238 | RSS: Main: 171855872 03:21:52 INFO - PID 4238 | 03:21:54 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59116/tests/kraken/driver.html?testName=audio-oscillator) 03:21:54 INFO - PID 4238 | RSS: Main: 172785664 03:21:54 INFO - PID 4238 | 03:21:57 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59116/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:21:57 INFO - PID 4238 | RSS: Main: 172322816 03:21:57 INFO - PID 4238 | 03:22:00 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59116/tests/kraken/driver.html?testName=imaging-darkroom) 03:22:01 INFO - PID 4238 | RSS: Main: 175321088 03:22:01 INFO - PID 4238 | 03:22:04 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59116/tests/kraken/driver.html?testName=imaging-desaturate) 03:22:05 INFO - PID 4238 | RSS: Main: 175415296 03:22:05 INFO - PID 4238 | 03:22:08 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59116/tests/kraken/driver.html?testName=json-parse-financial) 03:22:08 INFO - PID 4238 | RSS: Main: 175792128 03:22:08 INFO - PID 4238 | 03:22:10 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59116/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:22:11 INFO - PID 4238 | RSS: Main: 175894528 03:22:11 INFO - PID 4238 | 03:22:12 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59116/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:22:13 INFO - PID 4238 | RSS: Main: 175046656 03:22:13 INFO - PID 4238 | 03:22:15 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59116/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:22:16 INFO - PID 4238 | RSS: Main: 172904448 03:22:16 INFO - PID 4238 | 03:22:19 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59116/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:22:19 INFO - PID 4238 | RSS: Main: 173400064 03:22:19 INFO - PID 4238 | 03:22:22 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59116/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:22:23 INFO - PID 4238 | RSS: Main: 173772800 03:22:23 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | Cycle 1(1): loaded http://localhost:59116/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59116/tests/kraken/driver.html?testName=ai-astar) 03:22:25 INFO - PID 4238 | RSS: Main: 174964736 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | __start_tp_report 03:22:25 INFO - PID 4238 | _x_x_mozilla_page_load 03:22:25 INFO - PID 4238 | _x_x_mozilla_page_load_details 03:22:25 INFO - PID 4238 | |i|pagename|runs| 03:22:25 INFO - PID 4238 | |0;ai-astar;100;110;103;108;111;109;108;101;108;110 03:22:25 INFO - PID 4238 | |1;audio-beat-detection;146;121;153;174;119;143;150;119;170;123 03:22:25 INFO - PID 4238 | |2;audio-dft;163;163;164;163;161;162;167;166;164;166 03:22:25 INFO - PID 4238 | |3;audio-fft;75;77;76;172;77;76;76;75;164;77 03:22:25 INFO - PID 4238 | |4;audio-oscillator;79;79;131;79;78;79;125;79;80;131 03:22:25 INFO - PID 4238 | |5;imaging-gaussian-blur;114;117;114;114;113;116;114;114;113;114 03:22:25 INFO - PID 4238 | |6;imaging-darkroom;151;151;152;160;151;152;151;150;150;150 03:22:25 INFO - PID 4238 | |7;imaging-desaturate;94;94;94;94;94;99;94;95;94;95 03:22:25 INFO - PID 4238 | |8;json-parse-financial;57;65;57;57;57;57;57;56;57;58 03:22:25 INFO - PID 4238 | |9;json-stringify-tinderbox;54;55;55;55;55;54;54;55;55;55 03:22:25 INFO - PID 4238 | |10;stanford-crypto-aes;80;81;89;80;81;81;82;82;79;79 03:22:25 INFO - PID 4238 | |11;stanford-crypto-ccm;130;137;130;129;131;135;133;140;142;172 03:22:25 INFO - PID 4238 | |12;stanford-crypto-pbkdf2;189;199;196;184;186;185;191;183;183;179 03:22:25 INFO - PID 4238 | |13;stanford-crypto-sha256-iterative;71;70;71;70;73;71;69;68;68;69 03:22:25 INFO - PID 4238 | __end_tp_report 03:22:25 INFO - PID 4238 | __start_cc_report 03:22:25 INFO - PID 4238 | _x_x_mozilla_cycle_collect,937 03:22:25 INFO - PID 4238 | __end_cc_report 03:22:25 INFO - PID 4238 | __startTimestamp1501410145670__endTimestamp 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | ------- Summary: start ------- 03:22:25 INFO - PID 4238 | Number of tests: 14 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#0] ai-astar Cycles:10 Average:106.80 Median:108.50 stddev:3.97 (3.7%) stddev-sans-first:3.36 03:22:25 INFO - PID 4238 | Values: 100.0 110.0 103.0 108.0 111.0 109.0 108.0 101.0 108.0 110.0 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:148.00 stddev:20.74 (14.0%) stddev-sans-first:21.94 03:22:25 INFO - PID 4238 | Values: 146.0 121.0 153.0 174.0 119.0 143.0 150.0 119.0 170.0 123.0 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:1.91 (1.2%) stddev-sans-first:2.00 03:22:25 INFO - PID 4238 | Values: 163.0 163.0 164.0 163.0 161.0 162.0 167.0 166.0 164.0 166.0 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:38.79 (51.0%) stddev-sans-first:40.50 03:22:25 INFO - PID 4238 | Values: 75.0 77.0 76.0 172.0 77.0 76.0 76.0 75.0 164.0 77.0 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:79.00 stddev:24.21 (30.6%) stddev-sans-first:25.06 03:22:25 INFO - PID 4238 | Values: 79.0 79.0 131.0 79.0 78.0 79.0 125.0 79.0 80.0 131.0 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.25 (1.1%) stddev-sans-first:1.32 03:22:25 INFO - PID 4238 | Values: 114.0 117.0 114.0 114.0 113.0 116.0 114.0 114.0 113.0 114.0 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:151.00 stddev:2.97 (2.0%) stddev-sans-first:3.14 03:22:25 INFO - PID 4238 | Values: 151.0 151.0 152.0 160.0 151.0 152.0 151.0 150.0 150.0 150.0 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.57 (1.7%) stddev-sans-first:1.64 03:22:25 INFO - PID 4238 | Values: 94.0 94.0 94.0 94.0 94.0 99.0 94.0 95.0 94.0 95.0 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.00 stddev:2.57 (4.5%) stddev-sans-first:2.71 03:22:25 INFO - PID 4238 | Values: 57.0 65.0 57.0 57.0 57.0 57.0 57.0 56.0 57.0 58.0 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 03:22:25 INFO - PID 4238 | Values: 54.0 55.0 55.0 55.0 55.0 54.0 54.0 55.0 55.0 55.0 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#10] stanford-crypto-aes Cycles:10 Average:81.40 Median:81.00 stddev:2.88 (3.5%) stddev-sans-first:3.00 03:22:25 INFO - PID 4238 | Values: 80.0 81.0 89.0 80.0 81.0 81.0 82.0 82.0 79.0 79.0 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:136.00 stddev:12.78 (9.4%) stddev-sans-first:13.23 03:22:25 INFO - PID 4238 | Values: 130.0 137.0 130.0 129.0 131.0 135.0 133.0 140.0 142.0 172.0 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.50 Median:187.50 stddev:6.26 (3.3%) stddev-sans-first:6.61 03:22:25 INFO - PID 4238 | Values: 189.0 199.0 196.0 184.0 186.0 185.0 191.0 183.0 183.0 179.0 03:22:25 INFO - PID 4238 | 03:22:25 INFO - PID 4238 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:1.56 (2.2%) stddev-sans-first:1.62 03:22:25 INFO - PID 4238 | Values: 71.0 70.0 71.0 70.0 73.0 71.0 69.0 68.0 68.0 69.0 03:22:25 INFO - PID 4238 | -------- Summary: end -------- 03:22:25 INFO - PID 4238 | 03:22:26 INFO - PID 4238 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:22:26 INFO - TEST-INFO | 4238: exit 0 03:22:26 INFO - TEST-OK | kraken | took 62435ms 03:22:26 INFO - SUITE-END | took 1177s 03:22:26 INFO - Completed test suite (00:19:38) 03:22:26 INFO - javascript benchmark 03:22:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8487.951455473301, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3156.5265210218463, 3190.0908241151274, 3191.1543440988125, 3204.0227730542183, 3248.8538015789286, 6044.818655440333, 6116.969415152924, 6152.0, 6163.784267550636, 6172.0, 6006.579539432241, 6095.177151084602, 6096.878062438748, 6099.115628233903, 6137.754489820413, 5640.915386269209, 5650.943490565083, 5665.575081868856, 5682.602217844753, 5751.65490070595, 5663.971680141593, 5700.401457846929, 5756.0, 5781.364049954502, 5794.5074668653215, 5410.458954104558, 5585.8603534911545, 5590.8602284943, 5661.122526008476, 5664.40523745007, 5119.1553393690365, 5545.417731138253, 5550.000999820031, 5604.215409842625, 5616.971915140439, 5518.668879867221, 5524.254225679522, 5575.275214222166, 5594.748236329334, 5620.9437905621235, 5974.6713930733795, 6031.336552979169, 6085.148079268906, 6104.236970378703, 6118.4799292060225, 6656.234533028715, 6659.40065394112, 6685.832854178636, 6747.0, 6751.493637977172, 6717.798466046026, 6727.159105111861, 6801.863962720768, 6807.591544507345, 6824.488163387766, 6120.112583675342, 6217.067439884008, 6227.937720622826, 6289.968550157311, 6312.210973628296, 6780.932190678129, 6815.454763618898, 6815.522913396114, 6816.693248803816, 6823.1812182538415, 6429.164208652845, 6486.837829054217, 6493.545451818327, 6498.220213574401, 6501.252355979028, 6615.669216539154, 6622.668866556653, 6632.734690612418, 6634.900476492857, 6642.036904648799, 6594.07682924391, 6613.669316534154, 6618.0, 6618.96690516554, 6622.072909792633, 6622.569532980341, 6659.9001014984815, 6740.4270636995425, 6762.222344430454, 6768.221654509696, 5327.893442131136, 5397.730113494388, 5407.729613519308, 5409.107497262908, 5415.783368665288, 4542.136993971135, 4567.954320456753, 4570.223062079388, 4616.884577885579, 4638.257878739386, 5765.365809760923, 5797.0, 5800.39095894925, 5803.100519419497, 5803.767849285981, 6595.670216489157, 6650.600963942082, 6657.367550082734, 6680.96659516709, 6685.6322902240845, 5779.826605201851, 5789.594728369058, 5792.0, 5809.099589563624, 5871.178035075093, 5821.330546987066, 5918.0, 5929.970350148308, 5930.55520835939, 5941.70291485424, 6363.7772677956045, 6456.3543645636, 6487.870242595121, 6564.9671751640935, 6565.934340656532, 6597.406233439014, 6696.899546506709, 6700.329967003261, 6722.462203023649, 6722.9663851680425, 6388.0, 6458.160439143069, 6502.934970650422, 6503.154589903283, 6581.736730530725, 6625.105610742488, 6644.501662375244, 6712.39588437043, 6716.0, 6728.899066513908, 6595.505337099833, 6679.699413526306, 6680.3987641112535, 6732.697028633625, 6840.965795170992, 6440.162778838721, 6447.838804029937, 6457.644829534421, 6476.740930362921, 6587.242467116152, 6461.64460954652, 6531.771388001587, 6532.542722009413, 6534.444572211415, 6555.704993275219, 6495.317991610813, 6510.44661203803, 6516.641584712696, 6528.543001989815, 6535.183102112236, 6522.445592124723, 6537.542372034102, 6551.80344589663, 6624.0395142705, 6645.036469711961, 6162.568620196544, 6239.876822172053, 6247.687615619292, 6267.62394256346, 6420.6147631142285], "value": 6068.1122376634585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.5703976892249, 811.9878201826974, 847.9618417171229, 870.2515836380716, 875.8029443375241, 42212.36681449781, 42917.0, 42991.35512967308, 43046.56953430469, 43052.0, 39269.41095883564, 39590.0, 39635.80182099093, 39666.603333966654, 39753.20493590134, 7018.5788852668875, 7152.570845749272, 7159.57042577447, 7162.355388015078, 7163.964180179092, 7019.333163349474, 7117.537360071605, 7122.501424900259, 7126.8574628507395, 7130.572165670076, 7042.929570704304, 7067.151941766995, 7069.5758254504635, 7069.929300706978, 7081.185663648669, 7023.9999999999745, 7042.894356584656, 7076.469264805109, 7081.858362832741, 7083.0, 6382.329855365213, 6440.130582371414, 6444.613323200623, 6446.580972236837, 6450.387213214737, 34818.82590587056, 35112.47331290033, 35121.82439087814, 35166.64833351659, 35206.647933520595, 3375.6118046424485, 3422.2128910350757, 3426.6573342665783, 3428.8457019434186, 3431.1422144463886, 27712.168634940983, 27752.583711244348, 27753.861230693918, 27804.30489237765, 27848.443031139468, 4296.720713153666, 4302.634276086536, 4352.956470435319, 4361.672874534423, 4362.214801335758, 177999.0, 179708.0, 179873.0, 182848.0, 195080.99999999857, 50275.74862125739, 50515.7474212634, 50541.74729126331, 50549.0, 50562.241566376535, 52833.0, 52952.47047529552, 53013.734931325096, 53028.46971530312, 53070.0, 15979.920100399657, 16167.676646467005, 16173.353065877469, 16209.108499032667, 16448.671026579403, 13470.461181552824, 13484.932575337256, 13486.797698034341, 13497.460101596023, 13501.122427042212, 14074.085184463182, 14173.291335433187, 14203.218822964836, 14216.573502794932, 14396.712065758626, 5447.972760136174, 5448.291722076105, 5517.69652669107, 5531.419200983919, 5555.2778138841695, 972.4214092614883, 983.1348413396165, 1012.3419777144915, 1021.5709402051008, 1022.5858527296457, 22844.543109137725, 23104.884475577852, 23268.53462930732, 28734.856325718236, 29918.952836650613, 1059.2161800267747, 1089.9128069754559, 1092.0, 1101.6089288302696, 1107.9390633515234, 12370.876291237153, 12663.353764010619, 12667.176633518791, 12712.364381780873, 12781.041421893395, 217372.0, 217422.0, 217727.0, 218490.0, 218654.0, 54265.45734542604, 54281.72859135679, 54389.0, 54391.0, 54503.45496544984, 1448.167303800298, 1450.8476609955803, 1480.4966311454157, 1491.8806495480335, 1501.1068414293477, 21949.0, 22225.546961105723, 22416.551668966204, 22841.771582283964, 23072.884635576716, 50268.74865625649, 52740.47259527355, 53075.73462132664, 53396.46603533915, 53883.19175212296, 197338.0, 197343.0, 197584.0, 198282.0, 198721.0, 30685.693143069177, 31097.68902310948, 31170.376592468478, 32065.0, 34926.65073349234, 40486.19027619372, 45745.31382029339, 46001.0, 46823.0, 46883.53116468792, 31848.203794905312, 32617.836910815295, 32652.673473264964, 32684.0, 32845.178870527474, 30725.846370768897, 31518.684813151576, 32656.34687306288, 32987.17532061718, 33047.66952330446, 36568.817155914054, 36683.63316366802, 36714.0, 37039.8148009269, 37093.62906370902, 31876.36247275088, 32673.509897352033, 32972.0, 33015.33969320648, 33084.834575826964, 23485.765142349042, 23591.41021474477, 23898.761012389652, 23997.16009939644, 24383.26850194497], "value": 16949.121098520194, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.2016546586583, 571.3486625247216, 582.3142003898713, 589.9056151015837, 590.1148277583624, 22159.778402215972, 22905.0, 22980.425489362773, 23008.8849555752, 23039.0, 25687.743122568816, 26727.866360668217, 28023.579646305323, 28111.437771244564, 28189.57715634267, 7165.355118039375, 7338.889916651227, 7340.119185697724, 7343.302386273295, 7348.963255183717, 7263.673134708924, 7294.240994533075, 7326.81682957925, 7337.633118344062, 7337.706491740324, 6706.832329191785, 7169.713211471535, 7190.496665233436, 7204.567725936435, 7212.0, 7129.7861064168155, 7186.02988596538, 7195.676194571257, 7204.747833825791, 7210.4952653314285, 7013.929860701379, 7032.296770322978, 7033.8944915826305, 7049.89425158623, 7055.259197784261, 29439.558406623917, 30219.395612087854, 30625.928092516657, 30675.38649227003, 31474.685253147403, 1930.5463216144194, 1966.7246585478044, 1978.5053736565858, 1981.4947188466992, 1984.2162345873298, 20239.696404553943, 20653.17387304506, 20776.857272849986, 20890.0, 21028.158873645036, 2385.141349114335, 2409.506051259488, 2490.7297278387973, 2505.1983365323103, 2508.0344067533947, 138046.6195338044, 139566.0, 143508.0, 143614.0, 144044.27977860044, 20478.692819607717, 21781.23765668194, 23490.530189396457, 23583.528329433317, 24235.151769687975, 44074.77962610166, 44348.0, 44504.10991780146, 44551.55448445474, 44621.33068003983, 11700.765984680258, 11717.12121590884, 11754.177207595558, 11780.646580602595, 12074.335911524775, 9621.615135394646, 9727.173190278905, 9759.0, 9862.50687465624, 9911.454869982075, 8701.912980870236, 9303.767405814773, 11446.542138314375, 11687.707807304885, 11689.532418703157, 2727.345437095083, 2767.2113447667316, 2818.5208514552573, 2845.9430811384073, 2846.9361354906696, 945.5130607737021, 946.8153710026479, 966.2025683492533, 985.930984831055, 993.8956409577034, 18678.252869885324, 19402.4179274622, 23390.883045585004, 24932.626010609856, 25341.74658253394, 1015.2537884654773, 1023.1967905194387, 1026.9897301026895, 1052.321252791945, 1054.319963623474, 10947.50736216872, 11006.339619622848, 11242.943785281184, 11348.54605815758, 11355.0, 486879.0, 487220.0, 493432.0, 529150.0, 531624.0, 122081.0, 122140.38929805293, 123357.38321308515, 123999.3800030994, 125736.0, 1225.197495640357, 1268.6447794617523, 1293.359193869255, 1309.2340980526308, 1314.6581888708813, 19747.802521974598, 20073.29743458972, 20580.176792928116, 21225.0, 21638.35084947454, 56524.71737641285, 57244.71377643085, 57564.0, 57604.1359379618, 58580.0, 65613.0, 66845.66577167083, 67677.3232267671, 67681.3231867675, 67850.66074669595, 12467.877890989854, 14652.560423187322, 15003.324850381978, 15019.399224031353, 15030.924845375703, 22753.544929101656, 24287.878560607085, 24324.0, 24338.87830560836, 24453.144139955017, 18311.084445777924, 18598.721019184995, 18988.0, 19214.423567293004, 19337.70993435128, 16378.313733306377, 16489.422870199487, 16805.41181058657, 17542.12289385551, 17726.822731772518, 18830.811691883453, 19689.901550492155, 20188.495287617927, 20209.898950505154, 20212.696809547575, 14859.182744949132, 14869.18219497938, 15109.54671359861, 15122.319495622503, 15124.39502419891, 18174.0, 18571.25714971386, 18925.440239790183, 19090.14094365729, 19233.0], "value": 12927.969303621465, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.4781409157472, 1402.661665236736, 1408.9225092619902, 1419.1626940105348, 1427.2150317325475, 12137.0, 13432.126911750729, 14011.579652610413, 14114.505992290258, 14127.57617271481, 12101.394930253475, 13305.667358316046, 14189.92905035476, 14211.360488778004, 14230.075045122087, 2622.3313055170906, 2667.2531691126514, 2670.626112344273, 2671.7728993035616, 2691.825031372964, 2545.783608393289, 2636.6045093235975, 2645.193216069098, 2665.6934452537917, 2725.645666063419, 2643.2730998975244, 2686.6641669791275, 2688.0323083689855, 2688.8117831751783, 2689.4217743185213, 2607.4785042991384, 2637.5648018076995, 2642.563976943802, 2648.827826191301, 2660.2950218192195, 2610.6345111684377, 2617.5811870100883, 2634.4204275059647, 2654.7876169906363, 2656.296081538394, 13781.724365512733, 13845.723085538333, 13895.305234738324, 13903.513377031857, 13951.162930224218, 7579.393648508106, 7814.257645523666, 7846.764597062097, 7862.52824830512, 7870.921290787133, 5193.1171700810955, 5211.973940130275, 5367.973160134175, 5427.864303392407, 5519.39286678465, 1830.588117673526, 1840.089155867854, 1860.0885566072661, 1872.5505878589177, 1882.491727233653, 22426.32721018372, 22975.425614359607, 22975.54048919029, 22989.655155172684, 22990.770092299197, 6741.1236539249585, 6829.453643708492, 6850.623215723183, 7050.858982820315, 7070.434365250768, 18499.0, 18556.907215463838, 18558.0, 18564.97892615919, 18565.0, 7530.43521735872, 7687.692492300357, 7689.4232932530285, 7693.1922148173635, 7694.461387702919, 6779.864402711918, 6871.518993670495, 6900.378965893094, 6906.06768086312, 6945.201301850251, 5318.840434786963, 5482.972585137049, 5488.231647569343, 5491.945080549223, 5520.089185284383, 1532.5938626264049, 1558.8752899767992, 1626.2844348486628, 1683.4781217822515, 1728.3518680494815, 803.9075506316849, 808.6078252047752, 823.4236034775561, 825.0099880143852, 834.7495751274594, 7260.128784545888, 7375.262473752582, 7695.4997925134685, 7752.534847909031, 7755.72854950074, 908.246155690775, 912.115248209236, 943.5801068524578, 969.0842154164388, 985.2265971212564, 4391.8682439526865, 4797.832075877328, 4815.470298267188, 4867.610591152699, 4966.6771659842, 17738.91130544365, 18695.15871785773, 18726.719099213522, 18732.25070997145, 18760.24959001652, 17842.0, 19074.904625476785, 19145.904270478557, 19154.904225479062, 19182.616347672967, 10059.346142500714, 10207.846882296772, 10269.691909242734, 10285.640002600023, 10338.586456541805, 7290.817729556804, 7763.573003484863, 7915.208479152038, 8017.799555011172, 8029.277365037175, 16212.10833404174, 16361.754573681166, 16422.67154656924, 17005.064721439943, 17080.82919170842, 16324.836751632807, 16833.579160521083, 16952.0, 17008.65982680315, 17352.219150138022, 10825.458727063773, 11360.943195283971, 11380.43097845121, 11571.132165087483, 11590.652280431601, 13000.414981325674, 13082.542111026069, 13121.015923805944, 13126.474941002252, 13139.277339746406, 9973.102420781874, 10098.343607665773, 10150.340227885164, 10266.127379172854, 10454.372737635766, 9980.700578982642, 10236.89799410114, 10414.323069000491, 10530.210234232616, 10809.297395669257, 8489.108643592333, 8649.437786543855, 8658.870116948125, 8673.262772664142, 8680.739577812676, 5873.119032145212, 6119.663418511846, 6360.586561873463, 6362.236531616236, 6430.453411460078, 6332.588381755171, 6418.326075762165, 6435.581687190505, 6512.381323774234, 6551.21385433751], "value": 6300.399591762999, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.99370546140847, 504.17237514011686, 518.3520599250936, 524.824183898394, 525.1571228178773, 6174.9382506174925, 6185.752569897204, 6200.720967556459, 6269.404406581379, 6294.779682711106, 5907.0, 6118.235220597414, 6142.201513803199, 6146.293176284728, 6147.969260153704, 4865.002674451729, 4911.557959783619, 4924.187509061001, 4957.356343087837, 4994.076095922266, 4786.234202527597, 4948.1093403187415, 4953.1332016896895, 5008.348914641091, 5013.749312534377, 4852.757362131879, 4867.979788387815, 4894.36373271476, 4896.951030489685, 4947.802087916479, 4828.879278018043, 4869.293952376903, 4885.2427873679635, 4906.141425250585, 4952.479989601076, 4387.3857659927635, 4447.977760111211, 4468.642508599337, 4495.303227999665, 4501.527339629324, 6014.827108713803, 6028.909566356509, 6043.758249670008, 6074.815410994858, 6086.573939824169, 5602.971985140048, 5666.0, 5666.575006874501, 5678.545716342683, 5683.119116536944, 6463.57986730861, 6495.805125846185, 6557.672116394161, 6569.474442044625, 6597.505187110938, 4857.781399837016, 4876.829310974134, 4886.267059941002, 4905.4358748744, 4914.311996320518, 6806.727730890759, 6881.0, 6935.6878940448305, 6954.582725036514, 6999.0, 4931.276885951155, 4948.505149485023, 4962.429320628102, 5005.82479613219, 5007.499250074963, 5046.7476626168545, 5048.359283232964, 5060.468650791688, 5078.542931136216, 5130.589552835764, 5622.578306626938, 5669.688167150764, 5714.7428365723645, 5736.881308144955, 5739.569532285095, 6506.284308726036, 6508.544401891822, 6573.80278591643, 6575.178102737158, 6623.602583844985, 1653.2147230065864, 1705.2667353038064, 1711.5464401933498, 1714.485654303704, 1741.5733145379463, 1202.1765090912752, 1209.9395030248452, 1228.6252692928742, 1232.6502479784622, 1236.9567065152676, 5745.13822926556, 5766.654000759968, 5767.798127065533, 5772.855678607984, 5801.042827933428, 6514.902276465857, 6520.576162549514, 6579.572327798678, 6615.140031795836, 6702.731890724414, 5710.685912274782, 5764.481196692318, 5776.364599894008, 5839.240898683144, 5852.561057920673, 3579.677828995351, 3592.6946209571956, 3595.442706380515, 3612.4581312802766, 3615.6022837487853, 6514.869702605922, 6526.184226971629, 6546.0, 6577.375149360803, 6586.4072233498255, 6848.554843935129, 6873.347032031949, 6913.688884000232, 6960.721571137199, 6961.477889158334, 6505.779639078686, 6514.54398192122, 6516.609003459807, 6564.573302735307, 6565.507586930999, 6676.198856137295, 6689.096971908924, 6695.665216739046, 6749.4600431964345, 6750.0, 6678.899816502659, 6695.732170713117, 6699.363560461748, 6711.127553418024, 6719.462443004646, 6493.707783149675, 6513.641749703812, 6514.3811337922825, 6532.444742196966, 6568.6058836468055, 4980.701157930535, 5000.974995125001, 5001.649884508195, 5020.723860187724, 5026.52248036436, 6676.798176328308, 6689.364510371507, 6698.330166983263, 6711.46308295345, 6730.596164230162, 6390.201224846895, 6405.263394709668, 6511.186101737283, 6524.217093948757, 6554.0, 6256.468200203034, 6354.568532992317, 6546.24718157418, 6551.934480655133, 6561.572218279076, 6025.246844144482, 6329.145565348619, 6402.775902843378, 6453.774117906039, 6496.350364963466, 6525.804225873231, 6529.477641788741, 6542.771003014872, 6552.901706474502, 6560.475161986934, 6340.809775706736, 6346.904796427965, 6356.4279214870885, 6358.459530939922, 6380.138681278154], "value": 5038.307143919737, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.769283832623, 915.199200699388, 923.2291036984118, 924.1220840201805, 925.6852670092168, 18477.35329263476, 19362.225510979544, 19364.419067427963, 19372.128254228577, 19404.320848770294, 19706.901465492687, 20584.0, 21383.14467421305, 21723.565528689418, 21906.23328183514, 1012.4380968562444, 1037.590151890003, 1037.8131936251473, 1038.1124138861278, 1038.231708535682, 992.3748038735622, 1048.2505008918622, 1050.7845891592206, 1051.5005372448102, 1051.55834549489, 1100.0099910080912, 1101.372217835834, 1102.2119184782878, 1102.2284400919348, 1103.1340397787737, 1089.8637670291214, 1090.2095980414215, 1090.869095708512, 1091.683411810574, 1097.8243481043035, 796.8645330293864, 800.4756884240832, 801.7995501124719, 802.1617409806765, 808.9231523005305, 19222.711659325123, 19635.901820490948, 19875.0062496876, 19938.60122797536, 19981.600367992705, 20217.191312347488, 20571.691424628643, 20618.58762824735, 20642.27752028687, 20805.16779328825, 15663.686726265525, 15874.444394446138, 15882.523524294289, 16055.0, 16055.759163612554, 3460.3425349183576, 3470.5141280220537, 3480.843362048714, 3485.599156097056, 3490.0, 120765.0, 122349.0, 122493.0, 124812.37593812063, 128434.3578282112, 14745.631359216106, 15087.698246035017, 15126.848731512764, 15127.470538531099, 15158.31787569562, 27007.72992270052, 27258.182254532396, 27410.314742131206, 27414.45171096567, 27585.86207068952, 7890.447668663253, 8104.0, 8133.349332053422, 8447.662093516314, 8481.660733570712, 3986.5216174059296, 4012.4382586437923, 4082.3060079786505, 4092.324766413568, 4106.1582375612925, 4760.857174284777, 5049.545540901263, 5212.739363031909, 5494.587905907073, 5701.315842098892, 1076.155218153761, 1095.2278643556274, 1115.0967716149944, 1116.385987706758, 1120.2662256222188, 626.8871603111393, 665.8701553197177, 674.3256743256743, 686.3685409423342, 687.182253118787, 11528.827067593993, 11757.470913808898, 12121.818172727417, 12448.25310481374, 12869.4208760606, 618.1747367264752, 644.7227692092446, 649.5647915896361, 661.0579923608839, 669.4276393683427, 5246.947530524722, 5299.549538289211, 5385.272988146628, 5389.568834493231, 5506.972465137648, 99863.0, 100914.49542752239, 102848.0, 103882.0, 104917.0, 86370.56814715886, 91594.0, 92822.53588732013, 93202.53398732963, 96554.51722741482, 80579.01669830561, 82335.588322058, 84366.0, 85541.57229213814, 86274.0, 10361.792764144826, 10450.594464981577, 10639.627613033506, 10752.0, 10918.01737843598, 36970.63029369672, 38878.805605971786, 39137.41293880537, 39362.0, 39381.409278860265, 45459.0, 48105.0, 48423.27365089456, 48677.02645947132, 50152.0, 14750.336234869243, 14991.400343986556, 15068.171250581323, 15149.62125946816, 15162.924185379003, 16102.758458622895, 17089.230984605972, 17267.65464690674, 17542.561435964202, 20343.79656203419, 17687.292508300037, 18515.259389624804, 19028.714569281194, 19577.314793982143, 19723.112459939624, 19406.126724297723, 19609.509762256057, 19611.215551377783, 19688.31090911811, 20013.39959801208, 17261.482155535356, 17280.654386912443, 17323.82676173222, 18412.539686507407, 19099.61800764005, 12831.871681283068, 13211.801822972855, 13495.325233738471, 13698.726025479635, 13717.931410342884, 13025.283609401575, 14355.354009069408, 14616.41534338657, 14673.192974386511, 14749.852501474848], "value": 8859.425367950122, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 103.0, 108.0, 111.0, 109.0, 108.0, 101.0, 108.0, 110.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 153.0, 174.0, 119.0, 143.0, 150.0, 119.0, 170.0, 123.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 161.0, 162.0, 167.0, 166.0, 164.0, 166.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 172.0, 77.0, 76.0, 76.0, 75.0, 164.0, 77.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 131.0, 79.0, 78.0, 79.0, 125.0, 79.0, 80.0, 131.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 114.0, 114.0, 113.0, 116.0, 114.0, 114.0, 113.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 152.0, 160.0, 151.0, 152.0, 151.0, 150.0, 150.0, 150.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 99.0, 94.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 65.0, 57.0, 57.0, 57.0, 57.0, 57.0, 56.0, 57.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 55.0, 54.0, 54.0, 55.0, 55.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 89.0, 80.0, 81.0, 81.0, 82.0, 82.0, 79.0, 79.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 137.0, 130.0, 129.0, 131.0, 135.0, 133.0, 140.0, 142.0, 172.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 199.0, 196.0, 184.0, 186.0, 185.0, 191.0, 183.0, 183.0, 179.0], "value": 187.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 71.0, 70.0, 73.0, 71.0, 69.0, 68.0, 68.0, 69.0], "value": 70.0, "unit": "score"}]}]} 03:22:26 INFO - Return code: 0 03:22:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:22:26 INFO - # TBPL SUCCESS # 03:22:26 INFO - Running post-action listener: _package_coverage_data 03:22:26 INFO - Running post-action listener: _resource_record_post_action 03:22:26 INFO - [mozharness: 2017-07-30 10:22:26.946193Z] Finished run-tests step (success) 03:22:26 INFO - Running post-run listener: _resource_record_post_run 03:22:27 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 5980160; Write bytes: 441303040; Read time: 3708; Write time: 321912 03:22:27 INFO - TinderboxPrint: CPU usage
13.1% 03:22:27 INFO - TinderboxPrint: I/O read bytes / time
5,980,160 / 3,708 03:22:27 INFO - TinderboxPrint: I/O write bytes / time
441,303,040 / 321,912 03:22:27 INFO - TinderboxPrint: CPU idle
8,291.3 (86.9%) 03:22:27 INFO - TinderboxPrint: CPU user
1,199.2 (12.6%) 03:22:27 INFO - TinderboxPrint: Swap in / out
0 / 0 03:22:27 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 117780480; Read time: 0; Write time: 79816 03:22:27 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:22:27 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 3829760; Write bytes: 300822528; Read time: 3464; Write time: 235860 03:22:27 INFO - Running post-run listener: _upload_blobber_files 03:22:27 INFO - Blob upload gear active. 03:22:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:22:27 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:22:28 INFO - (blobuploader) - INFO - Open directory for files ... 03:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:29 INFO - (blobuploader) - INFO - Done attempting. 03:22:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:22:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:30 INFO - (blobuploader) - INFO - Done attempting. 03:22:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:22:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:22:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:31 INFO - (blobuploader) - INFO - Done attempting. 03:22:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:22:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:22:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:22:35 INFO - (blobuploader) - INFO - Done attempting. 03:22:35 INFO - (blobuploader) - INFO - Iteration through files over. 03:22:35 INFO - Return code: 0 03:22:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:22:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:22:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fce7e1739e700ad969d6d9c33e06a728c73cf852798fb2b1d683566498e4768c38438b9d41012e52bccb9c2e42023eb50d1752949b1a4b7fb6285066748fd62", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/606c267fdd8e15bde9ddef18c1cf7b2e934e1761ea8f1b6573b9de4db10f0d0c7a62b463a700629ef1352c004ce50ef4489512363edf7c431e756920c08c8b5b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/306a29bb59cc8236f0c14dd281343720ec6e186d14f5b346a0b91e1e4c2dd30a855fd849fa3b0b3ca7a1283c9ecb4a6ff1343193962f2b358479923637368ce7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9c8349a9a4be85a7489c5e20d13f803d37ee307bf4921fe596c71ae2b41c93989b934a48ff6f8e8c8a8f83dcdb1031fab8c26fd6239f6fa3cccb54418d3ba9d"} 03:22:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:22:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:22:35 INFO - Contents: 03:22:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fce7e1739e700ad969d6d9c33e06a728c73cf852798fb2b1d683566498e4768c38438b9d41012e52bccb9c2e42023eb50d1752949b1a4b7fb6285066748fd62", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/606c267fdd8e15bde9ddef18c1cf7b2e934e1761ea8f1b6573b9de4db10f0d0c7a62b463a700629ef1352c004ce50ef4489512363edf7c431e756920c08c8b5b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/306a29bb59cc8236f0c14dd281343720ec6e186d14f5b346a0b91e1e4c2dd30a855fd849fa3b0b3ca7a1283c9ecb4a6ff1343193962f2b358479923637368ce7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9c8349a9a4be85a7489c5e20d13f803d37ee307bf4921fe596c71ae2b41c93989b934a48ff6f8e8c8a8f83dcdb1031fab8c26fd6239f6fa3cccb54418d3ba9d"} 03:22:35 INFO - Running post-run listener: copy_logs_to_upload_dir 03:22:35 INFO - Copying logs to upload dir... 03:22:35 INFO - mkdir: /builds/slave/test/build/upload/logs 03:22:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.777878 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-07-30 03:22:35.205048) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 03:22:35.211616) ========= 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=781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208 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/3fce7e1739e700ad969d6d9c33e06a728c73cf852798fb2b1d683566498e4768c38438b9d41012e52bccb9c2e42023eb50d1752949b1a4b7fb6285066748fd62", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/606c267fdd8e15bde9ddef18c1cf7b2e934e1761ea8f1b6573b9de4db10f0d0c7a62b463a700629ef1352c004ce50ef4489512363edf7c431e756920c08c8b5b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/306a29bb59cc8236f0c14dd281343720ec6e186d14f5b346a0b91e1e4c2dd30a855fd849fa3b0b3ca7a1283c9ecb4a6ff1343193962f2b358479923637368ce7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9c8349a9a4be85a7489c5e20d13f803d37ee307bf4921fe596c71ae2b41c93989b934a48ff6f8e8c8a8f83dcdb1031fab8c26fd6239f6fa3cccb54418d3ba9d"} build_url:https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/Ci-E2TbxTwSnTt2-E0Fjxw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3fce7e1739e700ad969d6d9c33e06a728c73cf852798fb2b1d683566498e4768c38438b9d41012e52bccb9c2e42023eb50d1752949b1a4b7fb6285066748fd62", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/606c267fdd8e15bde9ddef18c1cf7b2e934e1761ea8f1b6573b9de4db10f0d0c7a62b463a700629ef1352c004ce50ef4489512363edf7c431e756920c08c8b5b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/306a29bb59cc8236f0c14dd281343720ec6e186d14f5b346a0b91e1e4c2dd30a855fd849fa3b0b3ca7a1283c9ecb4a6ff1343193962f2b358479923637368ce7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c9c8349a9a4be85a7489c5e20d13f803d37ee307bf4921fe596c71ae2b41c93989b934a48ff6f8e8c8a8f83dcdb1031fab8c26fd6239f6fa3cccb54418d3ba9d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-30 03:22:35.235547) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:22:35.235860) ========= 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=781b77c4c33858b1f599d705000001c1-1501401725.656433-1894160208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-30 03:22:35.321003) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 03:22:35.323353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-30 03:22:35.323657) ========= ========= Total master_lag: 0.27 =========