builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1501675628.45 results: success (0) revision: 60ee1059ee6c76d9dff806aee85bb29bcd20fba0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:08.453579) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:08.454077) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:08.454673) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:08.527515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:08.527826) ========= 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=ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-02 05:07:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-08-02 05:07:08 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175638 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:08.751693) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:08.755075) ========= 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=ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022575 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:08.805840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:08.809250) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 60ee1059ee6c76d9dff806aee85bb29bcd20fba0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 60ee1059ee6c76d9dff806aee85bb29bcd20fba0 --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=ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-02 05:07:08,922 truncating revision to first 12 chars 2017-08-02 05:07:08,922 Setting DEBUG logging. 2017-08-02 05:07:08,922 attempt 1/10 2017-08-02 05:07:08,923 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/60ee1059ee6c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-02 05:07:09,361 unpacking tar archive at: mozilla-beta-60ee1059ee6c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.744955 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:09.566624) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:09.569958) ========= script_repo_revision: 60ee1059ee6c76d9dff806aee85bb29bcd20fba0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:09.570358) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:09.570629) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 05:07:09.579151) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-02 05:07:09.579428) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-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=ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:07:09 INFO - MultiFileLogger online at 20170802 05:07:09 in /builds/slave/test 05:07:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 05:07:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:09 INFO - {'append_to_log': False, 05:07:09 INFO - 'base_work_dir': '/builds/slave/test', 05:07:09 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 05:07:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:09 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 05:07:09 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:09 INFO - 'code_coverage': False, 05:07:09 INFO - 'config_files': ('talos/linux_config.py',), 05:07:09 INFO - 'default_actions': ('clobber', 05:07:09 INFO - 'read-buildbot-config', 05:07:09 INFO - 'download-and-extract', 05:07:09 INFO - 'populate-webroot', 05:07:09 INFO - 'create-virtualenv', 05:07:09 INFO - 'install', 05:07:09 INFO - 'setup-mitmproxy', 05:07:09 INFO - 'run-tests'), 05:07:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:09 INFO - 'disable_ccov_upload': False, 05:07:09 INFO - 'download_minidump_stackwalk': True, 05:07:09 INFO - 'download_symbols': 'ondemand', 05:07:09 INFO - 'enable_stylo': False, 05:07:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:09 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:09 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:09 INFO - 'gecko_profile': False, 05:07:09 INFO - 'gecko_profile_interval': 0, 05:07:09 INFO - 'installer_path': 'installer.exe', 05:07:09 INFO - 'log_level': 'info', 05:07:09 INFO - 'log_name': 'talos', 05:07:09 INFO - 'log_to_console': True, 05:07:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:07:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:07:09 INFO - 'opt_config_files': (), 05:07:09 INFO - 'pip_index': False, 05:07:09 INFO - 'suite': 'dromaeojs-e10s', 05:07:09 INFO - 'system_bits': '32', 05:07:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:09 INFO - 'title': 'talos-linux64-ix-029', 05:07:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:09 INFO - 'use_talos_json': True, 05:07:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:09 INFO - 'work_dir': 'build'} 05:07:09 INFO - [mozharness: 2017-08-02 12:07:09.899485Z] Running clobber step. 05:07:09 INFO - Running pre-action listener: _resource_record_pre_action 05:07:09 INFO - Running main action method: clobber 05:07:09 INFO - rmtree: /builds/slave/test/build 05:07:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:10 INFO - Running post-action listener: _resource_record_post_action 05:07:10 INFO - [mozharness: 2017-08-02 12:07:10.885042Z] Finished clobber step (success) 05:07:10 INFO - [mozharness: 2017-08-02 12:07:10.885147Z] Running read-buildbot-config step. 05:07:10 INFO - Running pre-action listener: _resource_record_pre_action 05:07:10 INFO - Running main action method: read_buildbot_config 05:07:10 INFO - Using buildbot properties: 05:07:10 INFO - { 05:07:10 INFO - "project": "", 05:07:10 INFO - "product": "firefox", 05:07:10 INFO - "who": "ffxbld@noreply.mozilla.org", 05:07:10 INFO - "installer_path": "public/build/target.tar.bz2", 05:07:10 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 05:07:10 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 05:07:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 05:07:10 INFO - "stage_platform": "linux64", 05:07:10 INFO - "basedir": "/builds/slave/test", 05:07:10 INFO - "buildnumber": 37, 05:07:10 INFO - "platform": "ubuntu64_hw", 05:07:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:07:10 INFO - "slavebuilddir": "test", 05:07:10 INFO - "taskId": "PpBOHKK4QPW1S6_bCUMgGg", 05:07:10 INFO - "branch": "mozilla-beta", 05:07:10 INFO - "script_repo_revision": "production", 05:07:10 INFO - "revision": "60ee1059ee6c76d9dff806aee85bb29bcd20fba0", 05:07:10 INFO - "slavename": "talos-linux64-ix-029", 05:07:10 INFO - "repo_path": "releases/mozilla-beta" 05:07:10 INFO - } 05:07:10 INFO - Finding installer, test and symbols from parent task. 05:07:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PpBOHKK4QPW1S6_bCUMgGg'}, attempt #1 05:07:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PpBOHKK4QPW1S6_bCUMgGg'}, attempt #1 05:07:11 INFO - Task dependencies: YQiLO3_NSbK9rIPSloJRkw 05:07:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw'}, attempt #1 05:07:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.tar.bz2 05:07:12 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.test_packages.json 05:07:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.crashreporter-symbols.zip 05:07:12 INFO - Running post-action listener: _resource_record_post_action 05:07:12 INFO - [mozharness: 2017-08-02 12:07:12.375461Z] Finished read-buildbot-config step (success) 05:07:12 INFO - [mozharness: 2017-08-02 12:07:12.375686Z] Running download-and-extract step. 05:07:12 INFO - Running pre-action listener: _resource_record_pre_action 05:07:12 INFO - Running main action method: download_and_extract 05:07:12 INFO - mkdir: /builds/slave/test/build/tests 05:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:12 INFO - trying https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.test_packages.json 05:07:12 INFO - Downloading https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:07:12 INFO - Downloaded 989 bytes. 05:07:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:07:12 INFO - Using the following test package requirements: 05:07:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:07:12 INFO - u'common': [u'target.common.tests.zip'], 05:07:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:07:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:07:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:07:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:07:12 INFO - u'mozbase': [u'target.common.tests.zip'], 05:07:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:07:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:07:12 INFO - u'web-platform': [u'target.common.tests.zip', 05:07:12 INFO - u'target.web-platform.tests.tar.gz'], 05:07:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:07:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:07:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.common.tests.zip 05:07:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:07:12 INFO - Fetch https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.common.tests.zip into memory 05:07:14 INFO - Content-Length response header: 72853941 05:07:14 INFO - Bytes received: 72853941 05:07:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:07:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.common.tests.zip 05:07:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:07:26 INFO - Fetch https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.common.tests.zip into memory 05:07:28 INFO - Content-Length response header: 72853941 05:07:28 INFO - Bytes received: 72853941 05:07:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.talos.tests.zip 05:07:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:07:41 INFO - Fetch https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.talos.tests.zip into memory 05:07:42 INFO - Content-Length response header: 14496467 05:07:42 INFO - Bytes received: 14496467 05:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:42 INFO - trying https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.tar.bz2 05:07:42 INFO - Downloading https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:07:43 INFO - Downloaded 54030576 bytes. 05:07:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.tar.bz2 05:07:43 INFO - mkdir: /builds/slave/test/properties 05:07:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:43 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:43 INFO - Contents: 05:07:43 INFO - build_url:https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.tar.bz2 05:07:43 INFO - Running post-action listener: _resource_record_post_action 05:07:43 INFO - Running post-action listener: set_extra_try_arguments 05:07:43 INFO - [mozharness: 2017-08-02 12:07:43.542111Z] Finished download-and-extract step (success) 05:07:43 INFO - [mozharness: 2017-08-02 12:07:43.542209Z] Running populate-webroot step. 05:07:43 INFO - Running pre-action listener: _resource_record_pre_action 05:07:43 INFO - Running main action method: populate_webroot 05:07:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:07:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:07:43 INFO - 'tests': ['damp', 'tps']}, 05:07:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:07:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:07:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:07:43 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:43 INFO - 'ts_paint', 05:07:43 INFO - 'tpaint', 05:07:43 INFO - 'sessionrestore', 05:07:43 INFO - 'sessionrestore_many_windows', 05:07:43 INFO - 'sessionrestore_no_auto_restore', 05:07:43 INFO - 'tabpaint']}, 05:07:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:07:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:07:43 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:07:43 INFO - 'talos_options': ['--mitmproxy', 05:07:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:07:43 INFO - '--firstNonBlankPaint'], 05:07:43 INFO - 'tests': ['quantum_pageload_google', 05:07:43 INFO - 'quantum_pageload_youtube', 05:07:43 INFO - 'quantum_pageload_amazon', 05:07:43 INFO - 'quantum_pageload_facebook']}, 05:07:43 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:07:43 INFO - 'talos_options': ['--stylo', 05:07:43 INFO - '--mitmproxy', 05:07:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:07:43 INFO - '--firstNonBlankPaint'], 05:07:43 INFO - 'tests': ['quantum_pageload_google', 05:07:43 INFO - 'quantum_pageload_youtube', 05:07:43 INFO - 'quantum_pageload_amazon', 05:07:43 INFO - 'quantum_pageload_facebook']}, 05:07:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:43 INFO - 'tsvgr_opacity', 05:07:43 INFO - 'tart', 05:07:43 INFO - 'tscrollx', 05:07:43 INFO - 'cart', 05:07:43 INFO - 'tsvg_static']}, 05:07:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:07:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:07:43 INFO - 'talos_options': ['--stylo', 05:07:43 INFO - '--stylo-threads=1', 05:07:43 INFO - '--mitmproxy', 05:07:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:07:43 INFO - '--firstNonBlankPaint'], 05:07:43 INFO - 'tests': ['tp6_google', 05:07:43 INFO - 'tp6_youtube', 05:07:43 INFO - 'tp6_amazon', 05:07:43 INFO - 'tp6_facebook']}, 05:07:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:07:43 INFO - 'talos_options': ['--xperf_path', 05:07:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:43 INFO - 'tests': ['tp5n']}}} 05:07:43 INFO - Running post-action listener: _resource_record_post_action 05:07:43 INFO - [mozharness: 2017-08-02 12:07:43.550893Z] Finished populate-webroot step (success) 05:07:43 INFO - [mozharness: 2017-08-02 12:07:43.550983Z] Running create-virtualenv step. 05:07:43 INFO - Running pre-action listener: _resource_record_pre_action 05:07:43 INFO - Running main action method: create_virtualenv 05:07:43 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:07:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:07:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:43 INFO - Using real prefix '/usr' 05:07:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:44 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:46 INFO - Installing pip.................done. 05:07:46 INFO - Return code: 0 05:07:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:07:46 INFO - Reading from file tmpfile_stdout 05:07:46 INFO - Output received: 05:07:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:07:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:46 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 0x23b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2721eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271f050>, '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 0x271ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27203e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:07:46 INFO - Using env: {'DISPLAY': ':0', 05:07:46 INFO - 'HOME': '/home/cltbld', 05:07:46 INFO - 'LANG': 'en_US.UTF-8', 05:07:46 INFO - 'LANGUAGE': 'en_US:en', 05:07:46 INFO - 'LOGNAME': 'cltbld', 05:07:46 INFO - 'MAIL': '/var/mail/cltbld', 05:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:46 INFO - 'MOZ_NO_REMOTE': '1', 05:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:46 INFO - 'NO_EM_RESTART': '1', 05:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:46 INFO - 'PWD': '/builds/slave/test', 05:07:46 INFO - 'SHELL': '/bin/bash', 05:07:46 INFO - 'SHLVL': '1', 05:07:46 INFO - 'TERM': 'linux', 05:07:46 INFO - 'TMOUT': '86400', 05:07:46 INFO - 'USER': 'cltbld', 05:07:46 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 05:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:46 INFO - '_': '/tools/buildbot/bin/python'} 05:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:07:46 INFO - Cleaning up... 05:07:46 INFO - Return code: 0 05:07:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:46 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 0x23b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2721eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271f050>, '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 0x271ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27203e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:07:46 INFO - Using env: {'DISPLAY': ':0', 05:07:46 INFO - 'HOME': '/home/cltbld', 05:07:46 INFO - 'LANG': 'en_US.UTF-8', 05:07:46 INFO - 'LANGUAGE': 'en_US:en', 05:07:46 INFO - 'LOGNAME': 'cltbld', 05:07:46 INFO - 'MAIL': '/var/mail/cltbld', 05:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:46 INFO - 'MOZ_NO_REMOTE': '1', 05:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:46 INFO - 'NO_EM_RESTART': '1', 05:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:46 INFO - 'PWD': '/builds/slave/test', 05:07:46 INFO - 'SHELL': '/bin/bash', 05:07:46 INFO - 'SHLVL': '1', 05:07:46 INFO - 'TERM': 'linux', 05:07:46 INFO - 'TMOUT': '86400', 05:07:46 INFO - 'USER': 'cltbld', 05:07:46 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 05:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:46 INFO - '_': '/tools/buildbot/bin/python'} 05:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:47 INFO - Downloading/unpacking psutil>=3.1.1 05:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:48 INFO - Installing collected packages: psutil 05:07:48 INFO - Running setup.py install for psutil 05:07:48 INFO - building 'psutil._psutil_linux' extension 05:07:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:07:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:07:49 INFO - building 'psutil._psutil_posix' extension 05:07:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:07:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:07:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:49 INFO - Successfully installed psutil 05:07:49 INFO - Cleaning up... 05:07:49 INFO - Return code: 0 05:07:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:49 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 0x23b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2721eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271f050>, '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 0x271ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27203e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:07:49 INFO - Using env: {'DISPLAY': ':0', 05:07:49 INFO - 'HOME': '/home/cltbld', 05:07:49 INFO - 'LANG': 'en_US.UTF-8', 05:07:49 INFO - 'LANGUAGE': 'en_US:en', 05:07:49 INFO - 'LOGNAME': 'cltbld', 05:07:49 INFO - 'MAIL': '/var/mail/cltbld', 05:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:49 INFO - 'MOZ_NO_REMOTE': '1', 05:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:49 INFO - 'NO_EM_RESTART': '1', 05:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:49 INFO - 'PWD': '/builds/slave/test', 05:07:49 INFO - 'SHELL': '/bin/bash', 05:07:49 INFO - 'SHLVL': '1', 05:07:49 INFO - 'TERM': 'linux', 05:07:49 INFO - 'TMOUT': '86400', 05:07:49 INFO - 'USER': 'cltbld', 05:07:49 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 05:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:49 INFO - '_': '/tools/buildbot/bin/python'} 05:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:07:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:07:50 INFO - Installing collected packages: mozsystemmonitor 05:07:50 INFO - Running setup.py install for mozsystemmonitor 05:07:51 INFO - Successfully installed mozsystemmonitor 05:07:51 INFO - Cleaning up... 05:07:51 INFO - Return code: 0 05:07:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:51 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 0x23b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2721eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271f050>, '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 0x271ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27203e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:07:51 INFO - Using env: {'DISPLAY': ':0', 05:07:51 INFO - 'HOME': '/home/cltbld', 05:07:51 INFO - 'LANG': 'en_US.UTF-8', 05:07:51 INFO - 'LANGUAGE': 'en_US:en', 05:07:51 INFO - 'LOGNAME': 'cltbld', 05:07:51 INFO - 'MAIL': '/var/mail/cltbld', 05:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:51 INFO - 'MOZ_NO_REMOTE': '1', 05:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:51 INFO - 'NO_EM_RESTART': '1', 05:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:51 INFO - 'PWD': '/builds/slave/test', 05:07:51 INFO - 'SHELL': '/bin/bash', 05:07:51 INFO - 'SHLVL': '1', 05:07:51 INFO - 'TERM': 'linux', 05:07:51 INFO - 'TMOUT': '86400', 05:07:51 INFO - 'USER': 'cltbld', 05:07:51 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 05:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:51 INFO - '_': '/tools/buildbot/bin/python'} 05:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:51 INFO - Downloading/unpacking jsonschema==2.5.1 05:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:07:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:52 INFO - Downloading functools32-3.2.3-2.tar.gz 05:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:07:52 INFO - warning: no files found matching '*.txt' 05:07:52 INFO - no previously-included directories found matching 'build' 05:07:52 INFO - no previously-included directories found matching 'dist' 05:07:52 INFO - no previously-included directories found matching '.git*' 05:07:52 INFO - Installing collected packages: jsonschema, functools32 05:07:52 INFO - Running setup.py install for functools32 05:07:52 INFO - warning: no files found matching '*.txt' 05:07:52 INFO - no previously-included directories found matching 'build' 05:07:52 INFO - no previously-included directories found matching 'dist' 05:07:52 INFO - no previously-included directories found matching '.git*' 05:07:52 INFO - Successfully installed jsonschema functools32 05:07:52 INFO - Cleaning up... 05:07:52 INFO - Return code: 0 05:07:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:52 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 0x23b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2721eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271f050>, '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 0x271ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27203e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:07:52 INFO - Using env: {'DISPLAY': ':0', 05:07:52 INFO - 'HOME': '/home/cltbld', 05:07:52 INFO - 'LANG': 'en_US.UTF-8', 05:07:52 INFO - 'LANGUAGE': 'en_US:en', 05:07:52 INFO - 'LOGNAME': 'cltbld', 05:07:52 INFO - 'MAIL': '/var/mail/cltbld', 05:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:52 INFO - 'MOZ_NO_REMOTE': '1', 05:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:52 INFO - 'NO_EM_RESTART': '1', 05:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:52 INFO - 'PWD': '/builds/slave/test', 05:07:52 INFO - 'SHELL': '/bin/bash', 05:07:52 INFO - 'SHLVL': '1', 05:07:52 INFO - 'TERM': 'linux', 05:07:52 INFO - 'TMOUT': '86400', 05:07:52 INFO - 'USER': 'cltbld', 05:07:52 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 05:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:52 INFO - '_': '/tools/buildbot/bin/python'} 05:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:07:52 INFO - Cleaning up... 05:07:52 INFO - Return code: 0 05:07:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:52 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 0x23b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2721eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271f050>, '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 0x271ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27203e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:07:52 INFO - Using env: {'DISPLAY': ':0', 05:07:53 INFO - 'HOME': '/home/cltbld', 05:07:53 INFO - 'LANG': 'en_US.UTF-8', 05:07:53 INFO - 'LANGUAGE': 'en_US:en', 05:07:53 INFO - 'LOGNAME': 'cltbld', 05:07:53 INFO - 'MAIL': '/var/mail/cltbld', 05:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:53 INFO - 'MOZ_NO_REMOTE': '1', 05:07:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:53 INFO - 'NO_EM_RESTART': '1', 05:07:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:53 INFO - 'PWD': '/builds/slave/test', 05:07:53 INFO - 'SHELL': '/bin/bash', 05:07:53 INFO - 'SHLVL': '1', 05:07:53 INFO - 'TERM': 'linux', 05:07:53 INFO - 'TMOUT': '86400', 05:07:53 INFO - 'USER': 'cltbld', 05:07:53 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 05:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:53 INFO - '_': '/tools/buildbot/bin/python'} 05:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:53 INFO - Downloading/unpacking blobuploader==1.2.4 05:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:07:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:07:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:54 INFO - Downloading docopt-0.6.1.tar.gz 05:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:07:54 INFO - Installing collected packages: blobuploader, requests, docopt 05:07:54 INFO - Running setup.py install for blobuploader 05:07:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:07:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:07:54 INFO - Running setup.py install for requests 05:07:55 INFO - Running setup.py install for docopt 05:07:55 INFO - Successfully installed blobuploader requests docopt 05:07:55 INFO - Cleaning up... 05:07:55 INFO - Return code: 0 05:07:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:55 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 0x23b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2721eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271f050>, '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 0x271ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27203e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:07:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:07:55 INFO - Using env: {'DISPLAY': ':0', 05:07:55 INFO - 'HOME': '/home/cltbld', 05:07:55 INFO - 'LANG': 'en_US.UTF-8', 05:07:55 INFO - 'LANGUAGE': 'en_US:en', 05:07:55 INFO - 'LOGNAME': 'cltbld', 05:07:55 INFO - 'MAIL': '/var/mail/cltbld', 05:07:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:55 INFO - 'MOZ_NO_REMOTE': '1', 05:07:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:55 INFO - 'NO_EM_RESTART': '1', 05:07:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:55 INFO - 'PWD': '/builds/slave/test', 05:07:55 INFO - 'SHELL': '/bin/bash', 05:07:55 INFO - 'SHLVL': '1', 05:07:55 INFO - 'TERM': 'linux', 05:07:55 INFO - 'TMOUT': '86400', 05:07:55 INFO - 'USER': 'cltbld', 05:07:55 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 05:07:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:55 INFO - '_': '/tools/buildbot/bin/python'} 05:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:55 INFO - Running setup.py (path:/tmp/pip-oJgWxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:55 INFO - Running setup.py (path:/tmp/pip-Z7MwKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:55 INFO - Running setup.py (path:/tmp/pip-X6xV9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:55 INFO - Running setup.py (path:/tmp/pip-5i9Tc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:55 INFO - Running setup.py (path:/tmp/pip-9NeOSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:56 INFO - Running setup.py (path:/tmp/pip-57DkYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:56 INFO - Running setup.py (path:/tmp/pip-FfSb2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:56 INFO - Running setup.py (path:/tmp/pip-9lXi57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:56 INFO - Running setup.py (path:/tmp/pip-Bo9cE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:56 INFO - Running setup.py (path:/tmp/pip-dNeb_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:56 INFO - Running setup.py (path:/tmp/pip-BYmvBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:56 INFO - Running setup.py (path:/tmp/pip-ijA0IL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:56 INFO - Running setup.py (path:/tmp/pip-6YLnON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:56 INFO - Running setup.py (path:/tmp/pip-ZsGnxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:56 INFO - Running setup.py (path:/tmp/pip-IOQo_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:56 INFO - Running setup.py (path:/tmp/pip-fAnkkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:56 INFO - Running setup.py (path:/tmp/pip-PBBq3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:07:56 INFO - Running setup.py install for manifestparser 05:07:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:07:56 INFO - Running setup.py install for mozcrash 05:07:57 INFO - Running setup.py install for mozdebug 05:07:57 INFO - Running setup.py install for mozdevice 05:07:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozfile 05:07:57 INFO - Running setup.py install for mozhttpd 05:07:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozinfo 05:07:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozInstall 05:07:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozleak 05:07:57 INFO - Running setup.py install for mozlog 05:07:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for moznetwork 05:07:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:07:57 INFO - Running setup.py install for mozprocess 05:07:58 INFO - Running setup.py install for mozprofile 05:07:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Running setup.py install for mozrunner 05:07:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Running setup.py install for mozscreenshot 05:07:58 INFO - Running setup.py install for moztest 05:07:58 INFO - Running setup.py install for mozversion 05:07:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:07:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:07:58 INFO - Cleaning up... 05:07:58 INFO - Return code: 0 05:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:58 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 0x23b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2721eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271f050>, '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 0x271ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27203e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:07:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:07:58 INFO - Using env: {'DISPLAY': ':0', 05:07:58 INFO - 'HOME': '/home/cltbld', 05:07:58 INFO - 'LANG': 'en_US.UTF-8', 05:07:58 INFO - 'LANGUAGE': 'en_US:en', 05:07:58 INFO - 'LOGNAME': 'cltbld', 05:07:58 INFO - 'MAIL': '/var/mail/cltbld', 05:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:58 INFO - 'MOZ_NO_REMOTE': '1', 05:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:07:58 INFO - 'NO_EM_RESTART': '1', 05:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:58 INFO - 'PWD': '/builds/slave/test', 05:07:58 INFO - 'SHELL': '/bin/bash', 05:07:58 INFO - 'SHLVL': '1', 05:07:58 INFO - 'TERM': 'linux', 05:07:58 INFO - 'TMOUT': '86400', 05:07:58 INFO - 'USER': 'cltbld', 05:07:58 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 05:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:58 INFO - '_': '/tools/buildbot/bin/python'} 05:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:58 INFO - Running setup.py (path:/tmp/pip-H92uSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:58 INFO - Running setup.py (path:/tmp/pip-J_yyYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:59 INFO - Running setup.py (path:/tmp/pip-di42Qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:59 INFO - Running setup.py (path:/tmp/pip-vyix7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:59 INFO - Running setup.py (path:/tmp/pip-d3wYie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:59 INFO - Running setup.py (path:/tmp/pip-Kf2ToN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:59 INFO - Running setup.py (path:/tmp/pip-gVvYkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:59 INFO - Running setup.py (path:/tmp/pip-_kSAyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:59 INFO - Running setup.py (path:/tmp/pip-Hw4Bei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:59 INFO - Running setup.py (path:/tmp/pip-N_9rQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:59 INFO - Running setup.py (path:/tmp/pip-BCngd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:59 INFO - Running setup.py (path:/tmp/pip-_Qhr2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:59 INFO - Running setup.py (path:/tmp/pip-h_lyLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:59 INFO - Running setup.py (path:/tmp/pip-cGfDmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:59 INFO - Running setup.py (path:/tmp/pip-nm1_rK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:59 INFO - Running setup.py (path:/tmp/pip-4EQc10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:08:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:00 INFO - Running setup.py (path:/tmp/pip-_V1Ily-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:00 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:08:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:01 INFO - Downloading blessings-1.6.tar.gz 05:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:01 INFO - Installing collected packages: blessings 05:08:01 INFO - Running setup.py install for blessings 05:08:01 INFO - Successfully installed blessings 05:08:01 INFO - Cleaning up... 05:08:01 INFO - Return code: 0 05:08:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:01 INFO - Reading from file tmpfile_stdout 05:08:01 INFO - Current package versions: 05:08:01 INFO - argparse == 1.2.1 05:08:01 INFO - blessings == 1.6 05:08:01 INFO - blobuploader == 1.2.4 05:08:01 INFO - docopt == 0.6.1 05:08:01 INFO - functools32 == 3.2.3-2 05:08:01 INFO - jsonschema == 2.5.1 05:08:01 INFO - manifestparser == 1.1 05:08:01 INFO - mozInstall == 1.13 05:08:01 INFO - mozcrash == 1.0 05:08:01 INFO - mozdebug == 0.1 05:08:01 INFO - mozdevice == 0.51 05:08:01 INFO - mozfile == 1.2 05:08:01 INFO - mozhttpd == 0.7 05:08:01 INFO - mozinfo == 0.10 05:08:01 INFO - mozleak == 0.1 05:08:01 INFO - mozlog == 3.5 05:08:01 INFO - moznetwork == 0.27 05:08:01 INFO - mozprocess == 0.25 05:08:01 INFO - mozprofile == 0.28 05:08:01 INFO - mozrunner == 6.13 05:08:01 INFO - mozscreenshot == 0.1 05:08:01 INFO - mozsystemmonitor == 0.3 05:08:01 INFO - moztest == 0.8 05:08:01 INFO - mozversion == 1.4 05:08:01 INFO - psutil == 3.1.1 05:08:01 INFO - requests == 1.2.3 05:08:01 INFO - wsgiref == 0.1.2 05:08:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:01 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 0x23b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2721eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271f050>, '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 0x271ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27203e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:01 INFO - Using env: {'DISPLAY': ':0', 05:08:01 INFO - 'HOME': '/home/cltbld', 05:08:01 INFO - 'LANG': 'en_US.UTF-8', 05:08:01 INFO - 'LANGUAGE': 'en_US:en', 05:08:01 INFO - 'LOGNAME': 'cltbld', 05:08:01 INFO - 'MAIL': '/var/mail/cltbld', 05:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:01 INFO - 'MOZ_NO_REMOTE': '1', 05:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:01 INFO - 'NO_EM_RESTART': '1', 05:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:01 INFO - 'PWD': '/builds/slave/test', 05:08:01 INFO - 'SHELL': '/bin/bash', 05:08:01 INFO - 'SHLVL': '1', 05:08:01 INFO - 'TERM': 'linux', 05:08:01 INFO - 'TMOUT': '86400', 05:08:01 INFO - 'USER': 'cltbld', 05:08:01 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 05:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:01 INFO - '_': '/tools/buildbot/bin/python'} 05:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:08:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:08:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:08:03 INFO - Installing collected packages: simplejson 05:08:03 INFO - Running setup.py install for simplejson 05:08:03 INFO - building 'simplejson._speedups' extension 05:08:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 05:08:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 05:08:04 INFO - Successfully installed simplejson 05:08:04 INFO - Cleaning up... 05:08:04 INFO - Return code: 0 05:08:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:04 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 0x23b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2721eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x271f050>, '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 0x271ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27203e0>, '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': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:08:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:08:04 INFO - Using env: {'DISPLAY': ':0', 05:08:04 INFO - 'HOME': '/home/cltbld', 05:08:04 INFO - 'LANG': 'en_US.UTF-8', 05:08:04 INFO - 'LANGUAGE': 'en_US:en', 05:08:04 INFO - 'LOGNAME': 'cltbld', 05:08:04 INFO - 'MAIL': '/var/mail/cltbld', 05:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:04 INFO - 'MOZ_NO_REMOTE': '1', 05:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:04 INFO - 'NO_EM_RESTART': '1', 05:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:04 INFO - 'PWD': '/builds/slave/test', 05:08:04 INFO - 'SHELL': '/bin/bash', 05:08:04 INFO - 'SHLVL': '1', 05:08:04 INFO - 'TERM': 'linux', 05:08:04 INFO - 'TMOUT': '86400', 05:08:04 INFO - 'USER': 'cltbld', 05:08:04 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 05:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:04 INFO - '_': '/tools/buildbot/bin/python'} 05:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:08:04 INFO - Cleaning up... 05:08:04 INFO - Return code: 0 05:08:04 INFO - Running post-action listener: _resource_record_post_action 05:08:04 INFO - Running post-action listener: _start_resource_monitoring 05:08:04 INFO - Starting resource monitoring. 05:08:04 INFO - [mozharness: 2017-08-02 12:08:04.392888Z] Finished create-virtualenv step (success) 05:08:04 INFO - [mozharness: 2017-08-02 12:08:04.393969Z] Running install step. 05:08:04 INFO - Running pre-action listener: _resource_record_pre_action 05:08:04 INFO - Running main action method: install 05:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:04 INFO - Reading from file tmpfile_stdout 05:08:04 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:04 INFO - Reading from file tmpfile_stdout 05:08:04 INFO - Output received: 05:08:04 INFO - Usage: mozinstall [options] installer 05:08:04 INFO - Options: 05:08:04 INFO - -h, --help show this help message and exit 05:08:04 INFO - -d DEST, --destination=DEST 05:08:04 INFO - Directory to install application into. [default: 05:08:04 INFO - "/builds/slave/test"] 05:08:04 INFO - --app=APP Application being installed. [default: firefox] 05:08:04 INFO - mkdir: /builds/slave/test/build/application 05:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:08:19 INFO - Reading from file tmpfile_stdout 05:08:19 INFO - Output received: 05:08:19 INFO - /builds/slave/test/build/application/firefox/firefox 05:08:19 INFO - Running post-action listener: _resource_record_post_action 05:08:19 INFO - [mozharness: 2017-08-02 12:08:19.511517Z] Finished install step (success) 05:08:19 INFO - [mozharness: 2017-08-02 12:08:19.511770Z] Running setup-mitmproxy step. 05:08:19 INFO - Running pre-action listener: _resource_record_pre_action 05:08:19 INFO - Running main action method: setup_mitmproxy 05:08:19 INFO - Skipping: mitmproxy is not required 05:08:19 INFO - Running post-action listener: _resource_record_post_action 05:08:19 INFO - [mozharness: 2017-08-02 12:08:19.512897Z] Finished setup-mitmproxy step (success) 05:08:19 INFO - [mozharness: 2017-08-02 12:08:19.513117Z] Running run-tests step. 05:08:19 INFO - Running pre-action listener: _resource_record_pre_action 05:08:19 INFO - Running pre-action listener: _set_gcov_prefix 05:08:19 INFO - Running main action method: run_tests 05:08:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:08:19 INFO - Python 2.7.3 05:08:19 INFO - Return code: 0 05:08:19 INFO - grabbing minidump binary from tooltool 05:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:19 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 0x271f050>, '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 0x271ff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27203e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:08:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:08:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:08:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:08:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:19 INFO - Return code: 0 05:08:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:08:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:08:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:08:19 INFO - ENV: RUST_BACKTRACE is now 1 05:08:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:08:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:08:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:08:19 INFO - Using env: {'DISPLAY': ':0', 05:08:19 INFO - 'HOME': '/home/cltbld', 05:08:19 INFO - 'LANG': 'en_US.UTF-8', 05:08:19 INFO - 'LANGUAGE': 'en_US:en', 05:08:19 INFO - 'LOGNAME': 'cltbld', 05:08:19 INFO - 'MAIL': '/var/mail/cltbld', 05:08:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:08:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:19 INFO - 'MOZ_NO_REMOTE': '1', 05:08:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:19 INFO - 'NO_EM_RESTART': '1', 05:08:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:19 INFO - 'PWD': '/builds/slave/test', 05:08:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:08:19 INFO - 'RUST_BACKTRACE': '1', 05:08:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:08:19 INFO - 'SHELL': '/bin/bash', 05:08:19 INFO - 'SHLVL': '1', 05:08:19 INFO - 'TERM': 'linux', 05:08:19 INFO - 'TMOUT': '86400', 05:08:19 INFO - 'USER': 'cltbld', 05:08:19 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046', 05:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:19 INFO - '_': '/tools/buildbot/bin/python'} 05:08:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:08:20 INFO - mozversion application_buildid: 20170802084641 05:08:20 INFO - mozversion application_changeset: 60ee1059ee6c76d9dff806aee85bb29bcd20fba0 05:08:20 INFO - mozversion application_display_name: Firefox 05:08:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:20 INFO - mozversion application_name: Firefox 05:08:20 INFO - mozversion application_remotingname: firefox 05:08:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:08:20 INFO - mozversion application_vendor: Mozilla 05:08:20 INFO - mozversion application_version: 56.0 05:08:20 INFO - mozversion platform_buildid: 20170802084641 05:08:20 INFO - mozversion platform_changeset: 60ee1059ee6c76d9dff806aee85bb29bcd20fba0 05:08:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:08:20 INFO - mozversion platform_version: 56.0 05:08:20 INFO - using testdate: 1501675700 05:08:20 INFO - actual date: 1501675700 05:08:20 INFO - starting webserver on 'localhost:47335' 05:08:20 INFO - SUITE-START | Running 2 tests 05:08:20 INFO - TEST-START | dromaeo_css 05:08:20 INFO - Initialising browser for dromaeo_css test... 05:08:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47335/getInfo.html -profile /tmp/tmp4Fdgh7/profile 05:08:20 INFO - TEST-INFO | started process 3362 (/builds/slave/test/build/application/firefox/firefox http://localhost:47335/getInfo.html) 05:08:27 INFO - TEST-INFO | 3362: exit 0 05:08:27 INFO - Browser initialized. 05:08:27 INFO - Running cycle 1/1 for dromaeo_css test... 05:08:27 INFO - TEST-INFO | started process 3533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Fdgh7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:27 INFO - PID 3533 | 1501675707547 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4391 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 05:08:28 INFO - PID 3533 | 05:08:28 INFO - PID 3533 | (/builds/slave/test/build/application/firefox/firefox:3582): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:08:28 INFO - PID 3533 | 05:08:38 INFO - PID 3533 | RSS: Main: 139919360 05:08:38 INFO - PID 3533 | 05:11:35 INFO - PID 3533 | Cycle 1(1): loaded http://localhost:47335/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47335/tests/dromaeo/cssquery-ext.html) 05:11:37 INFO - PID 3533 | RSS: Main: 149692416 05:11:37 INFO - PID 3533 | 05:14:38 INFO - PID 3533 | Cycle 1(1): loaded http://localhost:47335/tests/dromaeo/cssquery-ext.html (next: http://localhost:47335/tests/dromaeo/cssquery-jquery.html) 05:14:39 INFO - PID 3533 | RSS: Main: 148168704 05:14:39 INFO - PID 3533 | 05:17:40 INFO - PID 3533 | Cycle 1(1): loaded http://localhost:47335/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47335/tests/dromaeo/cssquery-mootools.html) 05:17:41 INFO - PID 3533 | RSS: Main: 149876736 05:17:41 INFO - PID 3533 | 05:20:43 INFO - PID 3533 | Cycle 1(1): loaded http://localhost:47335/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47335/tests/dromaeo/cssquery-prototype.html) 05:20:43 INFO - PID 3533 | RSS: Main: 148369408 05:20:43 INFO - PID 3533 | 05:23:46 INFO - PID 3533 | Cycle 1(1): loaded http://localhost:47335/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47335/tests/dromaeo/cssquery-yui.html) 05:23:47 INFO - PID 3533 | RSS: Main: 152502272 05:23:47 INFO - PID 3533 | 05:26:48 INFO - PID 3533 | Cycle 1(1): loaded http://localhost:47335/tests/dromaeo/cssquery-yui.html (next: http://localhost:47335/tests/dromaeo/cssquery-dojo.html) 05:26:49 INFO - PID 3533 | RSS: Main: 155500544 05:26:49 INFO - PID 3533 | 05:26:49 INFO - PID 3533 | __start_tp_report 05:26:49 INFO - PID 3533 | _x_x_mozilla_page_load 05:26:49 INFO - PID 3533 | _x_x_mozilla_page_load_details 05:26:49 INFO - PID 3533 | |i|pagename|runs| 05:26:49 INFO - PID 3533 | |0;dojo.html;3487.616362200159;3556.3954127798274;3580.874669386572;3585.748997570171;3597.460380942858;6343.397377249165;6369.394907483787;6372.426481616653;6451.129097571832;6452.257990331113;6400.551961362707;6421.64680942548;6457.451116655078;6462.386073323027;6480.222373315209;5524.58565607579;5548.056830338832;5621.971890140544;5629.549636029108;5637.210790489335;5605.5515558755205;5613.46672066153;5617.129344951519;5680.11958146488;5698.971505142468;5557.972210138923;5635;5643.887122257573;5645.294338207724;5693.829185124453;5536.806211782568;5591.3569939456665;5605.523530499912;5610.579206559524;5623.775048998035;5555.388907220203;5594.049011668027;5602.38373778884;5617.297837770278;5623.718814059322;6173.259208894961;6243.625382477066;6246.812595622138;6312.747490100391;6406;6877.65611719412;6927.549709268881;6943.027976083353;6947.826304342432;6951.513394062417;6879.346462086094;6880.827979300508;6972.337627925339;6975.337342952412;6978;6376.39424254695;6396.552241343108;6424.71088801005;6444.2266927968;6445.613263204223;6984.755533556301;7063.964680176567;7070.222275549685;7070.68181931804;7076.893846592306;6770.424513916274;6798.694058767367;6805.6597170141295;6826.863462730717;6836.726530938806;6893.138357705287;6895.482838787111;6944.895826562605;6953.304669533108;6982;6703;6827.180738311435;6831.6242606657115;6836.418904393182;6880.621565813928;6852.246252912176;6936.445084393236;6940.583564986117;6940.861182776316;6942.687579058955;4959.876003099951;5067.5185857343495;5075.3402057732255;5105.387353517602;5118.232265160255;4516.683832131719;4563.840265590688;4567.10941366437;4585.312203169551;4598.241290187082;6385.680715964183;6512.41388275048;6513.869722605521;6587.275399706028;6590.8352291193105;6868.278830722702;6869.931300687029;6871.553349032397;6873.690683919235;6904.965475172592;6476.028595710681;6498.317676643979;6539.47684185264;6543.509236807258;6572.014197870358;5798.855028624318;5839.970800145972;5843.094320380348;5848.093545500455;5849.6782676952325;7035.190953040364;7045.084139061992;7074.787756367317;7141.107361579802;7160.355567998905;6827.2490026098085;6901.516893817385;6917.757878474229;6973.12835895513;6973.302669732986;7024;7045.718171273296;7075.115610548682;7090.929090709027;7142.464315176487;6794.218664853605;6818.079559259437;6865.862682746218;6915.997180408913;6920.619365934721;6738.629375384401;6913.930860691329;6920.134983127109;6995.335443132894;7006.579605223703;6652.334766523309;6652.667366631552;6657.467402607683;6659.600423974577;6660.034295027291;6570.638614876228;6593.3736295051895;6614.867702646016;6627.204735431586;6769.526133170631;6770.01834733951;6772.796816095525;6790.253072162157;6792.660366981532;6803.421709154777;6742.561733487308;6789.626570538668;6820.897686534805;6885.173779146334;6886.208086070166;6499.837504062436;6581.6709164542535;6618.0403841443685;6688.398044176048;6697.229818570732 05:26:49 INFO - PID 3533 | |1;ext.html;859.7225793618063;923.26139088729;943.2736792669643;964.0937518732391;977.062020460358;41764.79117604411;42718;42720.14559708804;42759.78620106895;42772.78613606928;40241.39637905426;40361.394579081265;40484.59515404845;40611.18777624446;40679.59320406795;6979.232284448719;7109.502334836538;7123.501354905133;7150.785476435689;7157.2842715728275;7047.224805271416;7145.928540714578;7149.928500714978;7152.392046676039;7159;7584.696612135508;7751.108622508399;7791.922080779176;7802.141764405939;7804.180561041094;7644.273793989562;7687.500312479699;7735.729249476241;7755.340796032344;7792.6493307801;7655.5837170123705;7707.845843083163;7718.6912523498995;7722.961385193094;7759.689612415553;40109.598904010876;40226.79886600548;40337;40337;40378.19243615111;3586.8027258500774;3588.7129029677562;3610.1335679437007;3627.7460577759566;3629.2197177606677;31417.84291078553;31459.52810707841;31461.8426907864;31591.52612710811;31604;4700.7179569225955;4728.361671174382;4746.928796068062;4767.880802979918;4838.371011768483;212541;216321;219037;221391;224965.87517062473;50356;50541.24188137181;50757;50767;50854.49145508498;51939.740301298254;52410.21384679233;52452;52472;52571;17817.46547603574;17875.46373608794;17877.37429189972;17924.462266132035;17929.282828686708;14880.851191488164;14936.477223297132;14948;14952.177630230224;15008.849911500964;14751.704965900622;14792.482263120739;14810.92594537042;14895.553133406016;14999.100053996577;5877.47102760745;6049.243844519435;6060.787872424444;6082.787102451393;6088.2694076710195;1070.384528895888;1092.5575142067476;1113.565709373345;1117.8770335263114;1122.4387806096952;24578.385540361633;25176.748232517806;25193.62209566858;25250.74749252484;25299.87350063238;1218.65268398506;1223.4311045363947;1228.4840367045863;1230.8030715085542;1240.7456471423336;13253.204807711569;13262.93368533151;13487.190768553723;17463.738043929352;17673.7348939766;300505;300864;301451;303686;304107;59725.40274597199;59804.70097649484;60008;60050.39949600448;60513;1556.9143697096542;1562.0705680120084;1578.6132397562671;1587.5951632333913;1594.3542865139405;29287;29432.26419339534;29444.852775735984;30185.396292074474;30462.390752185274;40025.59974400335;40220.79889600533;40223.396649050876;40276;40300;247478;248153;248970;249014;250060;34471.655283446846;39638.40542391924;40069.79965100156;40195;40287.79856100701;48278.75860620674;49498.01003979972;49834.25248621201;50039;50041.24938126004;35284.82357588196;35423.82288088543;35547.28905421825;35792.28415431729;35825.283494329444;35736.642633574374;35952.64047359597;36179.63820361763;36252.63747362493;36403;41232.79383603063;41610.58389416067;41614.791926040176;41705.37441938313;42063;34286.314273713884;34660;34845.477317839745;34951.12622184466;35461.1134721634;26183.607245891708;26465.603015955163;26777.330566735207;26984.32539186536;27495.175144745688 05:26:49 INFO - PID 3533 | |2;jquery.html;596.7911231069127;601.1943995046637;604.7671646416131;607.9057746049363;616.2143267334149;23241.535169296603;23790.881045594768;23796.28611141664;23867.403314917137;23872.64191037136;22143.778562214375;24356.512869742593;24374.025038998418;29347.706522934765;29361.559576606367;6324.905126423096;6443.935560644404;6445.838854028663;6450.6452145132;6451.29035806061;5997.460228579427;6555.44278736308;6562.114114594517;6593.53845230834;6598.8680226395445;6160.5687601867885;6206.038064100072;6210.223722034746;6211.534134939875;6214.3474935131835;6173.41352571505;6205.968970155143;6210.378962103753;6218.81343559694;6220.253569571635;5772.5670574707065;5800.0719884818645;5801.332846722638;5802.62282951611;5808.535317174616;30780.2304942376;31836;32151;32346;32379.514307285408;2273.6021196290585;2330.5105927755194;2338.4270853640796;2343.0979073056997;2343.425860664131;19046;19839.305624303226;19852.20591176351;19856.10647520865;19861.602767944703;2410.770976757205;2420.7942324902406;2467.938301542458;2487.751224877516;2500.099964012954;145937;152914;161249.19375403164;163520;170323.14838425853;15306.311215995307;15961.760573591406;16686.58283542921;16727.330906763593;16836.158192090348;25797.226083217534;25874.870625646752;25888.352791179994;25900.481990360087;25952.480950381265;11553.653390398302;11717.941410292893;11722.201123348437;11804.645860624196;11813.40932953349;10777;10829.404382758867;10848.837267440837;10875.619353322596;10892.509837057352;9902.60389584423;9989.200863930868;10130;10155.644552440777;10460.267781255392;2671.719469455718;2766.502029634685;2770.3766652503427;2804.130719476969;2826.759725423321;1018.760591261053;1040.3705758016442;1043.4939054558533;1051.348164138239;1073.1629329123296;21384.251551195634;22214.66677999831;25247.24258272255;26319.21042368732;26833.731662683513;1114.637742733615;1141.0928311991986;1152.17043728517;1153.1293873125903;1165.650304908524;11976.880231197576;15005.624859378602;15437;15524.14617196065;16051.839481605035;643025;663303;664615;665041;671120;145615;145971.2701436486;148698.25650871676;148704;149978.25010874876;1360.1974834847488;1365.877071063609;1388.1809732258016;1389.8262717160355;1398.6573289543924;23341.76658233396;23419.765802341757;23592.17427390033;23722.52554948926;23784;62813;64078.67960660167;64706;66193.33806661871;66638;78990.02524936922;79708.20291797008;79788;80076.19923800687;81694;15992.200389980222;16316.673666526365;16462.176891155155;16535.421260255833;16544.917275413547;24996.500069998863;25011.74988250167;25023.374415639755;25411;25427.491450171263;20042.799572004093;20123.295684650966;20250.59498809986;20261.59476810426;20547.4863128423;17834.643307134043;18224.72662910031;18348.266069357076;18521.35175268859;18706;20732;20872;21646.350609481742;21701.457463563536;22052;15928.442504512286;16115.355385784438;16161.595960100622;16213.865029447825;16253.349866005228;20073.698894516885;20620;20679.27622533204;20701.792982069986;20754.58490830205 05:26:49 INFO - PID 3533 | |3;mootools.html;1465.2966576043498;1503.8947273690846;1514.2958524286212;1517.0745845034523;1518.817741870975;15890.52328430146;15898.364065437383;16603.252853621587;16631.41790037349;16633.417830375925;16244.75632865508;17010.82989170108;17036;17055.40306089287;17082.145892705346;2928.5899974003655;2950.0707277207666;2991.55126730991;2997;2997.310618557733;2894.8263104213815;2935.5156399194107;2952.4537960477273;2983.284011837165;2994.625671791026;2964;2975.6577993530805;3011.683773203815;3021.6978302169828;3025.5310426883866;2894.305366711995;2896.362800183956;2924.239697678608;2931.3551018775834;3006.864691088906;2882.3658795065053;2918.3433727411375;2923.3276346440225;2931.457680329146;2934.926626834325;15566.688666226726;15818.367265309489;15867.365305387772;15939.282732276959;15942.20288985546;8105.189481051848;8376.246137847562;8380.371472139614;8385.454945428528;8386.077531471534;5252.842414727565;5303.814366497154;5433.1035379162395;5484.012877682016;5499.862503437406;1810.1944634637591;1813.9455816325399;1822.635472905411;1822.8723989320754;1856.0997916010724;27972;28330.433391332263;28345.71654283472;28367.57448638272;28368.432631347463;6807.65961701913;6892.862142757217;7000.964995174992;7087.964560177166;7156.427485801123;18587.25650973973;18665.626687466447;18666.440006799818;18672.906635466737;18682.06589670511;8353.081161072278;8418.326533877274;8427.662893484314;8462.111478294813;8504.362172836938;7809.80475488106;7827.491213071132;7939.0870049945;7941.126476087626;7954.204579542;5216.895662086737;5341.385740639798;5432.674039557639;5618.747156377891;5678.233438485834;1470.3236511204752;1475.5057055886398;1491.313995562032;1510.939562417491;1512.3345727879698;909.2044461096541;913.1690161952591;916.0473107967772;922.4419226368085;924.7456949338986;9215.354925155309;9445.905540944503;9475.431474111576;9571.37786043905;9609.087136722;1041.3023274406166;1064.180580952662;1077.0844781935293;1086.380762965118;1099.384344766933;5140.7943682253035;5248.3701955765555;5296.973515132399;5469.453054694499;6006.249218847644;22855.20006799754;23270;23926.52146957086;23932.52134957291;23967.52064958726;22549.549009019727;22983;23361.649575256386;23374.415639609146;23518.176863809684;12676.619701408972;12691.68270793256;12896;13061.673458163621;13166.539171128965;8607.48355098696;8623.180797824196;8644.91355086441;8721.91278087211;8740.91259087401;20073.498162546053;20179;20542.17831286732;20565.485862853548;20802.375928722162;20366.59266814685;20473;20666.586668266853;20867.269645562334;20963.895180524;13254.469821207043;13466.057375983588;13603.387847546686;13665.86334136646;13746.65633359174;13349;13825;15101.697966040398;15301.387944482096;15322.08067515908;12133.150679452354;12150.75698486043;12316.445759940645;12378.566750163702;12561.309127998047;11993.40032998364;12096.939515302367;12186.329751863732;12304.81542776877;12422.875771242172;9930.801383972135;10072.244581656552;10114.797704046025;10118.747031323981;10123.949380253052;7654.540727556142;7664.961675191588;7706.460547761827;7790.844183116419;7831.765047048598;7014.824629384102;7092.787216383516;7154.463415243774;7181.712731490682;7191.676374563052 05:26:49 INFO - PID 3533 | |4;prototype.html;538.2545174932717;555.3419198250076;559.5132234955589;565.8019693107412;570.3156212544947;6196.876062478747;6224.782132625359;6232.5013998880095;6237.376262373772;6249.5000399968;6130.957737184678;6135.785247516338;6142.692865356737;6161.199044124269;6168.136460895467;4946.925796113062;4947.208446648537;4956.578690811276;4989.501049895;4989.875253118665;4722.409698787652;4852.320675105488;4929.605631549467;4930.728809915453;4943.802247910079;4754.786034628432;4788.952110478903;4798.568128868401;4828.493008234138;4829.661923665345;4726.385569875912;4756.571908528214;4785.306130611077;4786.449558300787;4794.280857871312;4321.978390108061;4334.219840428722;4372.3878656988045;4388;4405.185040767468;5929.792457264019;5941.940580594182;5979.910301345483;5990.64056156632;6003.249593800775;5686.071673088363;5713.685747283897;5752.309722833245;5803.158542011427;5812.779316343573;6539.64031978241;6548.476121910236;6569.67151642416;6571.835704107388;6597.901031484532;4950.257461380822;4968.279599458095;5000.74996250186;5023;5026.748662566857;6614.536982411233;6750.763723269711;6758.966205169041;6839.316068393171;6850.21222559407;5016;5129.102407078821;5130.333056702605;5140;5142.691438513626;5194.584433245332;5212.087884620252;5218.63469557135;5254.3169387979315;5256.763445644955;5808.448197421239;5843.737031833492;5851.61964472308;5855.824325270249;5860.912086318709;6567.737290508326;6567.770128045591;6611.900821487681;6660.234073081658;6683.465322774166;1768.9209582154874;1780.8869456589632;1784.5627821183894;1786.7945186303741;1787.4816303271905;1225.209739717877;1269.5239285268024;1276.1513593460431;1280.8398950131234;1296;6165.260168779685;6173.41352571505;6220.284667263322;6303.653299068504;6370.140031095835;6573;6616.503762217853;6645.767398141042;6674.028952773189;6733.360330768569;6045.848853778691;6155.538334624921;6236.656983865841;6262.436380725757;6279.3720627937755;3541.327147841902;3545.62770909056;3547.8935631931085;3563.893083207508;3588.569371675416;6618.536702430783;6775.22084960226;6777.423918966943;6836.213835408892;6887.552309099892;6664.566803157779;6843.213030501456;6867;6896.827579310558;6922.896156557656;6696.029075784081;6698.330166983263;6774.559653622498;6793.448389578994;6793.660316984131;6556.409923106752;6694;6705.362990515893;6790.777660021244;6811.829704257433;6582.637954912526;6612.669366531751;6615.503837212132;6622.569532980341;6625;6801.387875091265;6842.931570684428;6850.623215722983;6895.689693963684;6951.548149370275;5057.620678449204;5063.822766203165;5075.3148324975655;5097.515736005073;5137.486251374833;6410.391012853772;6578.605283682994;6606.801795945937;6729.798106056826;6769.255381907888;6374.872502550016;6402.231732191981;6458.7093580789915;6498.350164983463;6512.934870651233;6407.551471397144;6435.613863168225;6505;6517.706703198272;6549.345065493412;6432.09950606906;6494.824233881703;6524.67376631157;6534.869302614016;6537.607743535213;6485.6108633482145;6496.577722448214;6584.868302634016;6587.670616469253;6617.371349721769;6263.467605253422;6326.55714100027;6333.714982825692;6409.647469389042;6485.124508191334 05:26:49 INFO - PID 3533 | |5;yui.html;950.4819873169117;966.6230170233608;975.1516180922598;989.2531138990062;997.3018886779251;16808.243629036693;17190.91404542977;17204.82795172048;17572.56068598286;17869.7319540207;19699.901500492513;19766.20935162592;19836.504087397785;19862;19864.304749333776;1064.2284343850686;1071.4000159910436;1109.6227282723871;1116.13499537858;1117.4245263689206;1061.3048453263125;1108.2851560743316;1109.0905457524832;1110.3448965110583;1111.6776134920863;1144.3991904250292;1155.2721785275307;1159.5999380213814;1160.0371691496039;1160.0661467518687;1138.3852719531444;1150.177622999551;1151.6257216404701;1155.2548606148987;1158.1314014489133;831.9584020798997;841.0538144587339;846.5978660136448;850.3919697416316;853.2747164909777;18173.909130454264;18487.630247394976;18531;18540.536486587807;19220.903895480573;21134.365969020953;21236.044378003025;21564.56870862574;21621.567568648537;21691.240806571852;16257.51227463178;16357.509274721777;16381.590460238589;16393.34426622934;16556.089415082166;3790.8673196437994;3804.1821008483034;3804.2391521695495;3810.161764411825;3813.675837553811;136912;137399;137525;138884;145686;16772.245248963827;17439.912800435915;17957.371491997717;17965.191566379544;17991.190396432194;32687.83656081752;32815;32921.83539082337;32926.17684557905;33073.3385332292;9173.174414302744;9198.356115072014;9496.620135194653;9515.857262141073;9567.952160239294;4575.405197324327;4605.125026245003;4613.861584152413;4635.629149668019;4657.720536767804;5896.292444906553;5995.820125396158;6023.759049638053;6027.246594175728;6038.275406951194;1051.9211059170593;1091.7980173667897;1099.3074363151322;1106.2256420505678;1108.3626914524182;698.9091418115714;728.8360118973188;731.184729027131;743.7099531182843;757.246539693009;12556.937215313865;13285.468581256642;13804.240766757925;13953.581392558239;14007.789883151761;679.1341040173719;694.3611877073105;703.954242974205;707.6214225389392;708.0123228096776;5893.44012318829;5958;6051.909221361683;6162;6162.014077747628;122880;123219;125292;126083.36958315149;126377.36811315885;113164;113214.43392783149;113339;114935;117853;97077;99179.99999999856;99195;99583.50208248913;100141.49929250307;12028.15802893824;12048.156629035884;12095.637130886087;12150.149489535648;12345.691357716129;48041;48374.75812620914;49592;51536;52350;87142;87332;88247.55876220578;88755;94485;19300;20438.28466003683;20468.897655511628;20865.89567052155;20873.89563052175;22323.330300091024;22797.088116475155;23095.538089237783;23530.411739706644;24776.876115619307;20886.164553417693;21955.451113722283;21978.120875164816;22123.225687100876;22163.1134754608;22331.10675572959;22387.44031399228;22580.435489112904;22658.886705566365;23180.072797087927;20466.488337791674;21133.89433052825;21218.681719774526;21560.67658985148;21758.12967481283;13599.116057456235;13791.586252412444;13858.584242472742;13863.86136138666;14000.649983750487;15602;15737.213139342759;16317;16532.173391330627;16540.090295033406 05:26:49 INFO - PID 3533 | __end_tp_report 05:26:49 INFO - PID 3533 | __start_cc_report 05:26:49 INFO - PID 3533 | _x_x_mozilla_cycle_collect,266 05:26:49 INFO - PID 3533 | __end_cc_report 05:26:49 INFO - PID 3533 | __startTimestamp1501676809079__endTimestamp 05:26:49 INFO - PID 3533 | 05:26:49 INFO - PID 3533 | ------- Summary: start ------- 05:26:49 INFO - PID 3533 | Number of tests: 6 05:26:49 INFO - PID 3533 | 05:26:49 INFO - PID 3533 | [#0] dojo.html Cycles:165 Average:6343.39 Median:6652.33 stddev:798.95 (12.0%) stddev-sans-first:769.35 05:26:49 INFO - PID 3533 | Values: 3487.6 3556.4 3580.9 3585.7 3597.5 6343.4 6369.4 6372.4 6451.1 6452.3 6400.6 6421.6 6457.5 6462.4 6480.2 5524.6 5548.1 5622.0 5629.5 5637.2 5605.6 5613.5 5617.1 5680.1 5699.0 5558.0 5635.0 5643.9 5645.3 5693.8 5536.8 5591.4 5605.5 5610.6 5623.8 5555.4 5594.0 5602.4 5617.3 5623.7 6173.3 6243.6 6246.8 6312.7 6406.0 6877.7 6927.5 6943.0 6947.8 6951.5 6879.3 6880.8 6972.3 6975.3 6978.0 6376.4 6396.6 6424.7 6444.2 6445.6 6984.8 7064.0 7070.2 7070.7 7076.9 6770.4 6798.7 6805.7 6826.9 6836.7 6893.1 6895.5 6944.9 6953.3 6982.0 6703.0 6827.2 6831.6 6836.4 6880.6 6852.2 6936.4 6940.6 6940.9 6942.7 4959.9 5067.5 5075.3 5105.4 5118.2 4516.7 4563.8 4567.1 4585.3 4598.2 6385.7 6512.4 6513.9 6587.3 6590.8 6868.3 6869.9 6871.6 6873.7 6905.0 6476.0 6498.3 6539.5 6543.5 6572.0 5798.9 5840.0 5843.1 5848.1 5849.7 7035.2 7045.1 7074.8 7141.1 7160.4 6827.2 6901.5 6917.8 6973.1 6973.3 7024.0 7045.7 7075.1 7090.9 7142.5 6794.2 6818.1 6865.9 6916.0 6920.6 6738.6 6913.9 6920.1 6995.3 7006.6 6652.3 6652.7 6657.5 6659.6 6660.0 6570.6 6593.4 6614.9 6627.2 6769.5 6770.0 6772.8 6790.3 6792.7 6803.4 6742.6 6789.6 6820.9 6885.2 6886.2 6499.8 6581.7 6618.0 6688.4 6697.2 05:26:49 INFO - PID 3533 | 05:26:49 INFO - PID 3533 | [#1] ext.html Cycles:180 Average:43483.71 Median:38020.70 stddev:67406.98 (177.3%) stddev-sans-first:67520.10 05:26:49 INFO - PID 3533 | Values: 859.7 923.3 943.3 964.1 977.1 41764.8 42718.0 42720.1 42759.8 42772.8 40241.4 40361.4 40484.6 40611.2 40679.6 6979.2 7109.5 7123.5 7150.8 7157.3 7047.2 7145.9 7149.9 7152.4 7159.0 7584.7 7751.1 7791.9 7802.1 7804.2 7644.3 7687.5 7735.7 7755.3 7792.6 7655.6 7707.8 7718.7 7723.0 7759.7 40109.6 40226.8 40337.0 40337.0 40378.2 3586.8 3588.7 3610.1 3627.7 3629.2 31417.8 31459.5 31461.8 31591.5 31604.0 4700.7 4728.4 4746.9 4767.9 4838.4 212541.0 216321.0 219037.0 221391.0 224965.9 50356.0 50541.2 50757.0 50767.0 50854.5 51939.7 52410.2 52452.0 52472.0 52571.0 17817.5 17875.5 17877.4 17924.5 17929.3 14880.9 14936.5 14948.0 14952.2 15008.8 14751.7 14792.5 14810.9 14895.6 14999.1 5877.5 6049.2 6060.8 6082.8 6088.3 1070.4 1092.6 1113.6 1117.9 1122.4 24578.4 25176.7 25193.6 25250.7 25299.9 1218.7 1223.4 1228.5 1230.8 1240.7 13253.2 13262.9 13487.2 17463.7 17673.7 300505.0 300864.0 301451.0 303686.0 304107.0 59725.4 59804.7 60008.0 60050.4 60513.0 1556.9 1562.1 1578.6 1587.6 1594.4 29287.0 29432.3 29444.9 30185.4 30462.4 40025.6 40220.8 40223.4 40276.0 40300.0 247478.0 248153.0 248970.0 249014.0 250060.0 34471.7 39638.4 40069.8 40195.0 40287.8 48278.8 49498.0 49834.3 50039.0 50041.2 35284.8 35423.8 35547.3 35792.3 35825.3 35736.6 35952.6 36179.6 36252.6 36403.0 41232.8 41610.6 41614.8 41705.4 42063.0 34286.3 34660.0 34845.5 34951.1 35461.1 26183.6 26465.6 26777.3 26984.3 27495.2 05:26:49 INFO - PID 3533 | 05:26:49 INFO - PID 3533 | [#2] jquery.html Cycles:180 Average:42579.04 Median:12879.10 stddev:110658.38 (859.2%) stddev-sans-first:110923.91 05:26:49 INFO - PID 3533 | Values: 596.8 601.2 604.8 607.9 616.2 23241.5 23790.9 23796.3 23867.4 23872.6 22143.8 24356.5 24374.0 29347.7 29361.6 6324.9 6443.9 6445.8 6450.6 6451.3 5997.5 6555.4 6562.1 6593.5 6598.9 6160.6 6206.0 6210.2 6211.5 6214.3 6173.4 6206.0 6210.4 6218.8 6220.3 5772.6 5800.1 5801.3 5802.6 5808.5 30780.2 31836.0 32151.0 32346.0 32379.5 2273.6 2330.5 2338.4 2343.1 2343.4 19046.0 19839.3 19852.2 19856.1 19861.6 2410.8 2420.8 2467.9 2487.8 2500.1 145937.0 152914.0 161249.2 163520.0 170323.1 15306.3 15961.8 16686.6 16727.3 16836.2 25797.2 25874.9 25888.4 25900.5 25952.5 11553.7 11717.9 11722.2 11804.6 11813.4 10777.0 10829.4 10848.8 10875.6 10892.5 9902.6 9989.2 10130.0 10155.6 10460.3 2671.7 2766.5 2770.4 2804.1 2826.8 1018.8 1040.4 1043.5 1051.3 1073.2 21384.3 22214.7 25247.2 26319.2 26833.7 1114.6 1141.1 1152.2 1153.1 1165.7 11976.9 15005.6 15437.0 15524.1 16051.8 643025.0 663303.0 664615.0 665041.0 671120.0 145615.0 145971.3 148698.3 148704.0 149978.3 1360.2 1365.9 1388.2 1389.8 1398.7 23341.8 23419.8 23592.2 23722.5 23784.0 62813.0 64078.7 64706.0 66193.3 66638.0 78990.0 79708.2 79788.0 80076.2 81694.0 15992.2 16316.7 16462.2 16535.4 16544.9 24996.5 25011.7 25023.4 25411.0 25427.5 20042.8 20123.3 20250.6 20261.6 20547.5 17834.6 18224.7 18348.3 18521.4 18706.0 20732.0 20872.0 21646.4 21701.5 22052.0 15928.4 16115.4 16161.6 16213.9 16253.3 20073.7 20620.0 20679.3 20701.8 20754.6 05:26:49 INFO - PID 3533 | 05:26:49 INFO - PID 3533 | [#3] mootools.html Cycles:180 Average:10053.65 Median:28338.07 stddev:7253.02 (25.6%) stddev-sans-first:7244.66 05:26:49 INFO - PID 3533 | Values: 1465.3 1503.9 1514.3 1517.1 1518.8 15890.5 15898.4 16603.3 16631.4 16633.4 16244.8 17010.8 17036.0 17055.4 17082.1 2928.6 2950.1 2991.6 2997.0 2997.3 2894.8 2935.5 2952.5 2983.3 2994.6 2964.0 2975.7 3011.7 3021.7 3025.5 2894.3 2896.4 2924.2 2931.4 3006.9 2882.4 2918.3 2923.3 2931.5 2934.9 15566.7 15818.4 15867.4 15939.3 15942.2 8105.2 8376.2 8380.4 8385.5 8386.1 5252.8 5303.8 5433.1 5484.0 5499.9 1810.2 1813.9 1822.6 1822.9 1856.1 27972.0 28330.4 28345.7 28367.6 28368.4 6807.7 6892.9 7001.0 7088.0 7156.4 18587.3 18665.6 18666.4 18672.9 18682.1 8353.1 8418.3 8427.7 8462.1 8504.4 7809.8 7827.5 7939.1 7941.1 7954.2 5216.9 5341.4 5432.7 5618.7 5678.2 1470.3 1475.5 1491.3 1510.9 1512.3 909.2 913.2 916.0 922.4 924.7 9215.4 9445.9 9475.4 9571.4 9609.1 1041.3 1064.2 1077.1 1086.4 1099.4 5140.8 5248.4 5297.0 5469.5 6006.2 22855.2 23270.0 23926.5 23932.5 23967.5 22549.5 22983.0 23361.6 23374.4 23518.2 12676.6 12691.7 12896.0 13061.7 13166.5 8607.5 8623.2 8644.9 8721.9 8740.9 20073.5 20179.0 20542.2 20565.5 20802.4 20366.6 20473.0 20666.6 20867.3 20963.9 13254.5 13466.1 13603.4 13665.9 13746.7 13349.0 13825.0 15101.7 15301.4 15322.1 12133.2 12150.8 12316.4 12378.6 12561.3 11993.4 12096.9 12186.3 12304.8 12422.9 9930.8 10072.2 10114.8 10118.7 10123.9 7654.5 7665.0 7706.5 7790.8 7831.8 7014.8 7092.8 7154.5 7181.7 7191.7 05:26:49 INFO - PID 3533 | 05:26:49 INFO - PID 3533 | [#4] prototype.html Cycles:180 Average:5552.15 Median:6222.53 stddev:1557.30 (25.0%) stddev-sans-first:1515.52 05:26:49 INFO - PID 3533 | Values: 538.3 555.3 559.5 565.8 570.3 6196.9 6224.8 6232.5 6237.4 6249.5 6131.0 6135.8 6142.7 6161.2 6168.1 4946.9 4947.2 4956.6 4989.5 4989.9 4722.4 4852.3 4929.6 4930.7 4943.8 4754.8 4789.0 4798.6 4828.5 4829.7 4726.4 4756.6 4785.3 4786.4 4794.3 4322.0 4334.2 4372.4 4388.0 4405.2 5929.8 5941.9 5979.9 5990.6 6003.2 5686.1 5713.7 5752.3 5803.2 5812.8 6539.6 6548.5 6569.7 6571.8 6597.9 4950.3 4968.3 5000.7 5023.0 5026.7 6614.5 6750.8 6759.0 6839.3 6850.2 5016.0 5129.1 5130.3 5140.0 5142.7 5194.6 5212.1 5218.6 5254.3 5256.8 5808.4 5843.7 5851.6 5855.8 5860.9 6567.7 6567.8 6611.9 6660.2 6683.5 1768.9 1780.9 1784.6 1786.8 1787.5 1225.2 1269.5 1276.2 1280.8 1296.0 6165.3 6173.4 6220.3 6303.7 6370.1 6573.0 6616.5 6645.8 6674.0 6733.4 6045.8 6155.5 6236.7 6262.4 6279.4 3541.3 3545.6 3547.9 3563.9 3588.6 6618.5 6775.2 6777.4 6836.2 6887.6 6664.6 6843.2 6867.0 6896.8 6922.9 6696.0 6698.3 6774.6 6793.4 6793.7 6556.4 6694.0 6705.4 6790.8 6811.8 6582.6 6612.7 6615.5 6622.6 6625.0 6801.4 6842.9 6850.6 6895.7 6951.5 5057.6 5063.8 5075.3 5097.5 5137.5 6410.4 6578.6 6606.8 6729.8 6769.3 6374.9 6402.2 6458.7 6498.4 6512.9 6407.6 6435.6 6505.0 6517.7 6549.3 6432.1 6494.8 6524.7 6534.9 6537.6 6485.6 6496.6 6584.9 6587.7 6617.4 6263.5 6326.6 6333.7 6409.6 6485.1 05:26:49 INFO - PID 3533 | 05:26:49 INFO - PID 3533 | [#5] yui.html Cycles:180 Average:26792.42 Median:20869.90 stddev:37022.69 (177.4%) stddev-sans-first:37075.70 05:26:49 INFO - PID 3533 | Values: 950.5 966.6 975.2 989.3 997.3 16808.2 17190.9 17204.8 17572.6 17869.7 19699.9 19766.2 19836.5 19862.0 19864.3 1064.2 1071.4 1109.6 1116.1 1117.4 1061.3 1108.3 1109.1 1110.3 1111.7 1144.4 1155.3 1159.6 1160.0 1160.1 1138.4 1150.2 1151.6 1155.3 1158.1 832.0 841.1 846.6 850.4 853.3 18173.9 18487.6 18531.0 18540.5 19220.9 21134.4 21236.0 21564.6 21621.6 21691.2 16257.5 16357.5 16381.6 16393.3 16556.1 3790.9 3804.2 3804.2 3810.2 3813.7 136912.0 137399.0 137525.0 138884.0 145686.0 16772.2 17439.9 17957.4 17965.2 17991.2 32687.8 32815.0 32921.8 32926.2 33073.3 9173.2 9198.4 9496.6 9515.9 9568.0 4575.4 4605.1 4613.9 4635.6 4657.7 5896.3 5995.8 6023.8 6027.2 6038.3 1051.9 1091.8 1099.3 1106.2 1108.4 698.9 728.8 731.2 743.7 757.2 12556.9 13285.5 13804.2 13953.6 14007.8 679.1 694.4 704.0 707.6 708.0 5893.4 5958.0 6051.9 6162.0 6162.0 122880.0 123219.0 125292.0 126083.4 126377.4 113164.0 113214.4 113339.0 114935.0 117853.0 97077.0 99180.0 99195.0 99583.5 100141.5 12028.2 12048.2 12095.6 12150.1 12345.7 48041.0 48374.8 49592.0 51536.0 52350.0 87142.0 87332.0 88247.6 88755.0 94485.0 19300.0 20438.3 20468.9 20865.9 20873.9 22323.3 22797.1 23095.5 23530.4 24776.9 20886.2 21955.5 21978.1 22123.2 22163.1 22331.1 22387.4 22580.4 22658.9 23180.1 20466.5 21133.9 21218.7 21560.7 21758.1 13599.1 13791.6 13858.6 13863.9 14000.6 15602.0 15737.2 16317.0 16532.2 16540.1 05:26:49 INFO - PID 3533 | -------- Summary: end -------- 05:26:49 INFO - PID 3533 | 05:26:49 INFO - TEST-INFO | 3533: exit 0 05:26:49 INFO - TEST-OK | dromaeo_css | took 1109740ms 05:26:49 INFO - TEST-START | kraken 05:26:49 INFO - Initialising browser for kraken test... 05:26:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47335/getInfo.html -profile /tmp/tmp5fEbuK/profile 05:26:49 INFO - TEST-INFO | started process 3892 (/builds/slave/test/build/application/firefox/firefox http://localhost:47335/getInfo.html) 05:26:55 INFO - TEST-INFO | 3892: exit 0 05:26:55 INFO - Browser initialized. 05:26:55 INFO - Running cycle 1/1 for kraken test... 05:26:55 INFO - TEST-INFO | started process 4065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5fEbuK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:56 INFO - PID 4065 | 1501676816056 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4391 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 05:26:56 INFO - PID 4065 | 05:26:56 INFO - PID 4065 | (/builds/slave/test/build/application/firefox/firefox:4113): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:26:56 INFO - PID 4065 | 05:27:06 INFO - PID 4065 | RSS: Main: 139845632 05:27:06 INFO - PID 4065 | 05:27:09 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47335/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:10 INFO - PID 4065 | RSS: Main: 147243008 05:27:10 INFO - PID 4065 | 05:27:12 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47335/tests/kraken/driver.html?testName=audio-dft) 05:27:13 INFO - PID 4065 | RSS: Main: 147988480 05:27:13 INFO - PID 4065 | 05:27:16 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47335/tests/kraken/driver.html?testName=audio-fft) 05:27:16 INFO - PID 4065 | RSS: Main: 148299776 05:27:16 INFO - PID 4065 | 05:27:19 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47335/tests/kraken/driver.html?testName=audio-oscillator) 05:27:19 INFO - PID 4065 | RSS: Main: 148959232 05:27:19 INFO - PID 4065 | 05:27:21 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47335/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:22 INFO - PID 4065 | RSS: Main: 147947520 05:27:22 INFO - PID 4065 | 05:27:25 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47335/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:25 INFO - PID 4065 | RSS: Main: 148463616 05:27:25 INFO - PID 4065 | 05:27:29 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47335/tests/kraken/driver.html?testName=imaging-desaturate) 05:27:29 INFO - PID 4065 | RSS: Main: 151371776 05:27:29 INFO - PID 4065 | 05:27:32 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47335/tests/kraken/driver.html?testName=json-parse-financial) 05:27:33 INFO - PID 4065 | RSS: Main: 151404544 05:27:33 INFO - PID 4065 | 05:27:34 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47335/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:27:35 INFO - PID 4065 | RSS: Main: 150999040 05:27:35 INFO - PID 4065 | 05:27:37 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47335/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:27:37 INFO - PID 4065 | RSS: Main: 150921216 05:27:37 INFO - PID 4065 | 05:27:39 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47335/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:27:40 INFO - PID 4065 | RSS: Main: 151494656 05:27:40 INFO - PID 4065 | 05:27:42 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:27:43 INFO - PID 4065 | RSS: Main: 151486464 05:27:43 INFO - PID 4065 | 05:27:46 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:27:46 INFO - PID 4065 | RSS: Main: 152035328 05:27:46 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:47335/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47335/tests/kraken/driver.html?testName=ai-astar) 05:27:48 INFO - PID 4065 | RSS: Main: 153460736 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | __start_tp_report 05:27:48 INFO - PID 4065 | _x_x_mozilla_page_load 05:27:48 INFO - PID 4065 | _x_x_mozilla_page_load_details 05:27:48 INFO - PID 4065 | |i|pagename|runs| 05:27:48 INFO - PID 4065 | |0;ai-astar;96;107;100;105;106;107;107;98;106;108 05:27:48 INFO - PID 4065 | |1;audio-beat-detection;141;112;146;172;114;146;137;119;155;114 05:27:48 INFO - PID 4065 | |2;audio-dft;163;161;162;163;161;162;161;161;163;161 05:27:48 INFO - PID 4065 | |3;audio-fft;74;76;75;178;74;76;75;75;159;75 05:27:48 INFO - PID 4065 | |4;audio-oscillator;78;77;126;77;78;78;130;87;77;132 05:27:48 INFO - PID 4065 | |5;imaging-gaussian-blur;113;114;113;113;116;113;113;113;114;114 05:27:48 INFO - PID 4065 | |6;imaging-darkroom;149;148;148;148;150;148;148;148;149;148 05:27:48 INFO - PID 4065 | |7;imaging-desaturate;94;95;100;95;95;94;95;95;94;94 05:27:48 INFO - PID 4065 | |8;json-parse-financial;50;45;49;45;45;52;48;44;44;44 05:27:48 INFO - PID 4065 | |9;json-stringify-tinderbox;52;52;53;52;52;51;52;52;51;52 05:27:48 INFO - PID 4065 | |10;stanford-crypto-aes;74;73;72;73;73;76;74;72;74;79 05:27:48 INFO - PID 4065 | |11;stanford-crypto-ccm;113;116;123;112;116;114;113;112;129;138 05:27:48 INFO - PID 4065 | |12;stanford-crypto-pbkdf2;158;161;162;164;161;162;162;158;166;160 05:27:48 INFO - PID 4065 | |13;stanford-crypto-sha256-iterative;60;67;60;62;60;58;58;56;60;58 05:27:48 INFO - PID 4065 | __end_tp_report 05:27:48 INFO - PID 4065 | __start_cc_report 05:27:48 INFO - PID 4065 | _x_x_mozilla_cycle_collect,706 05:27:48 INFO - PID 4065 | __end_cc_report 05:27:48 INFO - PID 4065 | __startTimestamp1501676868747__endTimestamp 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | ------- Summary: start ------- 05:27:48 INFO - PID 4065 | Number of tests: 14 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#0] ai-astar Cycles:10 Average:104.00 Median:107.00 stddev:4.32 (4.0%) stddev-sans-first:3.48 05:27:48 INFO - PID 4065 | Values: 96.0 107.0 100.0 105.0 106.0 107.0 107.0 98.0 106.0 108.0 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:143.50 stddev:20.32 (14.2%) stddev-sans-first:21.45 05:27:48 INFO - PID 4065 | Values: 141.0 112.0 146.0 172.0 114.0 146.0 137.0 119.0 155.0 114.0 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 05:27:48 INFO - PID 4065 | Values: 163.0 161.0 162.0 163.0 161.0 162.0 161.0 161.0 163.0 161.0 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.00 stddev:39.68 (52.9%) stddev-sans-first:41.44 05:27:48 INFO - PID 4065 | Values: 74.0 76.0 75.0 178.0 74.0 76.0 75.0 75.0 159.0 75.0 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:77.50 stddev:24.60 (31.7%) stddev-sans-first:25.41 05:27:48 INFO - PID 4065 | Values: 78.0 77.0 126.0 77.0 78.0 78.0 130.0 87.0 77.0 132.0 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:113.50 stddev:0.97 (0.9%) stddev-sans-first:1.00 05:27:48 INFO - PID 4065 | Values: 113.0 114.0 113.0 113.0 116.0 113.0 113.0 113.0 114.0 114.0 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 05:27:48 INFO - PID 4065 | Values: 149.0 148.0 148.0 148.0 150.0 148.0 148.0 148.0 149.0 148.0 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:1.79 (1.9%) stddev-sans-first:1.86 05:27:48 INFO - PID 4065 | Values: 94.0 95.0 100.0 95.0 95.0 94.0 95.0 95.0 94.0 94.0 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#8] json-parse-financial Cycles:10 Average:46.60 Median:46.50 stddev:2.91 (6.3%) stddev-sans-first:2.82 05:27:48 INFO - PID 4065 | Values: 50.0 45.0 49.0 45.0 45.0 52.0 48.0 44.0 44.0 44.0 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#9] json-stringify-tinderbox Cycles:10 Average:51.90 Median:52.00 stddev:0.57 (1.1%) stddev-sans-first:0.60 05:27:48 INFO - PID 4065 | Values: 52.0 52.0 53.0 52.0 52.0 51.0 52.0 52.0 51.0 52.0 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:2.11 (2.8%) stddev-sans-first:2.24 05:27:48 INFO - PID 4065 | Values: 74.0 73.0 72.0 73.0 73.0 76.0 74.0 72.0 74.0 79.0 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:116.00 stddev:8.75 (7.5%) stddev-sans-first:9.04 05:27:48 INFO - PID 4065 | Values: 113.0 116.0 123.0 112.0 116.0 114.0 113.0 112.0 129.0 138.0 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:2.46 (1.5%) stddev-sans-first:2.28 05:27:48 INFO - PID 4065 | Values: 158.0 161.0 162.0 164.0 161.0 162.0 162.0 158.0 166.0 160.0 05:27:48 INFO - PID 4065 | 05:27:48 INFO - PID 4065 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.90 Median:60.00 stddev:3.00 (5.0%) stddev-sans-first:3.18 05:27:48 INFO - PID 4065 | Values: 60.0 67.0 60.0 62.0 60.0 58.0 58.0 56.0 60.0 58.0 05:27:48 INFO - PID 4065 | -------- Summary: end -------- 05:27:48 INFO - PID 4065 | 05:27:49 INFO - PID 4065 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:27:49 INFO - TEST-INFO | 4065: exit 0 05:27:49 INFO - TEST-OK | kraken | took 59898ms 05:27:49 INFO - SUITE-END | took 1169s 05:27:49 INFO - Completed test suite (00:19:29) 05:27:49 INFO - javascript benchmark 05:27:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9080.25953994725, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3487.616362200159, 3556.3954127798274, 3580.874669386572, 3585.748997570171, 3597.460380942858, 6343.397377249165, 6369.394907483787, 6372.426481616653, 6451.129097571832, 6452.257990331113, 6400.551961362707, 6421.64680942548, 6457.451116655078, 6462.386073323027, 6480.222373315209, 5524.58565607579, 5548.056830338832, 5621.971890140544, 5629.549636029108, 5637.210790489335, 5605.5515558755205, 5613.46672066153, 5617.129344951519, 5680.11958146488, 5698.971505142468, 5557.972210138923, 5635.0, 5643.887122257573, 5645.294338207724, 5693.829185124453, 5536.806211782568, 5591.3569939456665, 5605.523530499912, 5610.579206559524, 5623.775048998035, 5555.388907220203, 5594.049011668027, 5602.38373778884, 5617.297837770278, 5623.718814059322, 6173.259208894961, 6243.625382477066, 6246.812595622138, 6312.747490100391, 6406.0, 6877.65611719412, 6927.549709268881, 6943.027976083353, 6947.826304342432, 6951.513394062417, 6879.346462086094, 6880.827979300508, 6972.337627925339, 6975.337342952412, 6978.0, 6376.39424254695, 6396.552241343108, 6424.71088801005, 6444.2266927968, 6445.613263204223, 6984.755533556301, 7063.964680176567, 7070.222275549685, 7070.68181931804, 7076.893846592306, 6770.424513916274, 6798.694058767367, 6805.6597170141295, 6826.863462730717, 6836.726530938806, 6893.138357705287, 6895.482838787111, 6944.895826562605, 6953.304669533108, 6982.0, 6703.0, 6827.180738311435, 6831.6242606657115, 6836.418904393182, 6880.621565813928, 6852.246252912176, 6936.445084393236, 6940.583564986117, 6940.861182776316, 6942.687579058955, 4959.876003099951, 5067.5185857343495, 5075.3402057732255, 5105.387353517602, 5118.232265160255, 4516.683832131719, 4563.840265590688, 4567.10941366437, 4585.312203169551, 4598.241290187082, 6385.680715964183, 6512.41388275048, 6513.869722605521, 6587.275399706028, 6590.8352291193105, 6868.278830722702, 6869.931300687029, 6871.553349032397, 6873.690683919235, 6904.965475172592, 6476.028595710681, 6498.317676643979, 6539.47684185264, 6543.509236807258, 6572.014197870358, 5798.855028624318, 5839.970800145972, 5843.094320380348, 5848.093545500455, 5849.6782676952325, 7035.190953040364, 7045.084139061992, 7074.787756367317, 7141.107361579802, 7160.355567998905, 6827.2490026098085, 6901.516893817385, 6917.757878474229, 6973.12835895513, 6973.302669732986, 7024.0, 7045.718171273296, 7075.115610548682, 7090.929090709027, 7142.464315176487, 6794.218664853605, 6818.079559259437, 6865.862682746218, 6915.997180408913, 6920.619365934721, 6738.629375384401, 6913.930860691329, 6920.134983127109, 6995.335443132894, 7006.579605223703, 6652.334766523309, 6652.667366631552, 6657.467402607683, 6659.600423974577, 6660.034295027291, 6570.638614876228, 6593.3736295051895, 6614.867702646016, 6627.204735431586, 6769.526133170631, 6770.01834733951, 6772.796816095525, 6790.253072162157, 6792.660366981532, 6803.421709154777, 6742.561733487308, 6789.626570538668, 6820.897686534805, 6885.173779146334, 6886.208086070166, 6499.837504062436, 6581.6709164542535, 6618.0403841443685, 6688.398044176048, 6697.229818570732], "value": 6283.434537535695, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.7225793618063, 923.26139088729, 943.2736792669643, 964.0937518732391, 977.062020460358, 41764.79117604411, 42718.0, 42720.14559708804, 42759.78620106895, 42772.78613606928, 40241.39637905426, 40361.394579081265, 40484.59515404845, 40611.18777624446, 40679.59320406795, 6979.232284448719, 7109.502334836538, 7123.501354905133, 7150.785476435689, 7157.2842715728275, 7047.224805271416, 7145.928540714578, 7149.928500714978, 7152.392046676039, 7159.0, 7584.696612135508, 7751.108622508399, 7791.922080779176, 7802.141764405939, 7804.180561041094, 7644.273793989562, 7687.500312479699, 7735.729249476241, 7755.340796032344, 7792.6493307801, 7655.5837170123705, 7707.845843083163, 7718.6912523498995, 7722.961385193094, 7759.689612415553, 40109.598904010876, 40226.79886600548, 40337.0, 40337.0, 40378.19243615111, 3586.8027258500774, 3588.7129029677562, 3610.1335679437007, 3627.7460577759566, 3629.2197177606677, 31417.84291078553, 31459.52810707841, 31461.8426907864, 31591.52612710811, 31604.0, 4700.7179569225955, 4728.361671174382, 4746.928796068062, 4767.880802979918, 4838.371011768483, 212541.0, 216321.0, 219037.0, 221391.0, 224965.87517062473, 50356.0, 50541.24188137181, 50757.0, 50767.0, 50854.49145508498, 51939.740301298254, 52410.21384679233, 52452.0, 52472.0, 52571.0, 17817.46547603574, 17875.46373608794, 17877.37429189972, 17924.462266132035, 17929.282828686708, 14880.851191488164, 14936.477223297132, 14948.0, 14952.177630230224, 15008.849911500964, 14751.704965900622, 14792.482263120739, 14810.92594537042, 14895.553133406016, 14999.100053996577, 5877.47102760745, 6049.243844519435, 6060.787872424444, 6082.787102451393, 6088.2694076710195, 1070.384528895888, 1092.5575142067476, 1113.565709373345, 1117.8770335263114, 1122.4387806096952, 24578.385540361633, 25176.748232517806, 25193.62209566858, 25250.74749252484, 25299.87350063238, 1218.65268398506, 1223.4311045363947, 1228.4840367045863, 1230.8030715085542, 1240.7456471423336, 13253.204807711569, 13262.93368533151, 13487.190768553723, 17463.738043929352, 17673.7348939766, 300505.0, 300864.0, 301451.0, 303686.0, 304107.0, 59725.40274597199, 59804.70097649484, 60008.0, 60050.39949600448, 60513.0, 1556.9143697096542, 1562.0705680120084, 1578.6132397562671, 1587.5951632333913, 1594.3542865139405, 29287.0, 29432.26419339534, 29444.852775735984, 30185.396292074474, 30462.390752185274, 40025.59974400335, 40220.79889600533, 40223.396649050876, 40276.0, 40300.0, 247478.0, 248153.0, 248970.0, 249014.0, 250060.0, 34471.655283446846, 39638.40542391924, 40069.79965100156, 40195.0, 40287.79856100701, 48278.75860620674, 49498.01003979972, 49834.25248621201, 50039.0, 50041.24938126004, 35284.82357588196, 35423.82288088543, 35547.28905421825, 35792.28415431729, 35825.283494329444, 35736.642633574374, 35952.64047359597, 36179.63820361763, 36252.63747362493, 36403.0, 41232.79383603063, 41610.58389416067, 41614.791926040176, 41705.37441938313, 42063.0, 34286.314273713884, 34660.0, 34845.477317839745, 34951.12622184466, 35461.1134721634, 26183.607245891708, 26465.603015955163, 26777.330566735207, 26984.32539186536, 27495.175144745688], "value": 18572.584322227078, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.7911231069127, 601.1943995046637, 604.7671646416131, 607.9057746049363, 616.2143267334149, 23241.535169296603, 23790.881045594768, 23796.28611141664, 23867.403314917137, 23872.64191037136, 22143.778562214375, 24356.512869742593, 24374.025038998418, 29347.706522934765, 29361.559576606367, 6324.905126423096, 6443.935560644404, 6445.838854028663, 6450.6452145132, 6451.29035806061, 5997.460228579427, 6555.44278736308, 6562.114114594517, 6593.53845230834, 6598.8680226395445, 6160.5687601867885, 6206.038064100072, 6210.223722034746, 6211.534134939875, 6214.3474935131835, 6173.41352571505, 6205.968970155143, 6210.378962103753, 6218.81343559694, 6220.253569571635, 5772.5670574707065, 5800.0719884818645, 5801.332846722638, 5802.62282951611, 5808.535317174616, 30780.2304942376, 31836.0, 32151.0, 32346.0, 32379.514307285408, 2273.6021196290585, 2330.5105927755194, 2338.4270853640796, 2343.0979073056997, 2343.425860664131, 19046.0, 19839.305624303226, 19852.20591176351, 19856.10647520865, 19861.602767944703, 2410.770976757205, 2420.7942324902406, 2467.938301542458, 2487.751224877516, 2500.099964012954, 145937.0, 152914.0, 161249.19375403164, 163520.0, 170323.14838425853, 15306.311215995307, 15961.760573591406, 16686.58283542921, 16727.330906763593, 16836.158192090348, 25797.226083217534, 25874.870625646752, 25888.352791179994, 25900.481990360087, 25952.480950381265, 11553.653390398302, 11717.941410292893, 11722.201123348437, 11804.645860624196, 11813.40932953349, 10777.0, 10829.404382758867, 10848.837267440837, 10875.619353322596, 10892.509837057352, 9902.60389584423, 9989.200863930868, 10130.0, 10155.644552440777, 10460.267781255392, 2671.719469455718, 2766.502029634685, 2770.3766652503427, 2804.130719476969, 2826.759725423321, 1018.760591261053, 1040.3705758016442, 1043.4939054558533, 1051.348164138239, 1073.1629329123296, 21384.251551195634, 22214.66677999831, 25247.24258272255, 26319.21042368732, 26833.731662683513, 1114.637742733615, 1141.0928311991986, 1152.17043728517, 1153.1293873125903, 1165.650304908524, 11976.880231197576, 15005.624859378602, 15437.0, 15524.14617196065, 16051.839481605035, 643025.0, 663303.0, 664615.0, 665041.0, 671120.0, 145615.0, 145971.2701436486, 148698.25650871676, 148704.0, 149978.25010874876, 1360.1974834847488, 1365.877071063609, 1388.1809732258016, 1389.8262717160355, 1398.6573289543924, 23341.76658233396, 23419.765802341757, 23592.17427390033, 23722.52554948926, 23784.0, 62813.0, 64078.67960660167, 64706.0, 66193.33806661871, 66638.0, 78990.02524936922, 79708.20291797008, 79788.0, 80076.19923800687, 81694.0, 15992.200389980222, 16316.673666526365, 16462.176891155155, 16535.421260255833, 16544.917275413547, 24996.500069998863, 25011.74988250167, 25023.374415639755, 25411.0, 25427.491450171263, 20042.799572004093, 20123.295684650966, 20250.59498809986, 20261.59476810426, 20547.4863128423, 17834.643307134043, 18224.72662910031, 18348.266069357076, 18521.35175268859, 18706.0, 20732.0, 20872.0, 21646.350609481742, 21701.457463563536, 22052.0, 15928.442504512286, 16115.355385784438, 16161.595960100622, 16213.865029447825, 16253.349866005228, 20073.698894516885, 20620.0, 20679.27622533204, 20701.792982069986, 20754.58490830205], "value": 13217.959091101715, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1465.2966576043498, 1503.8947273690846, 1514.2958524286212, 1517.0745845034523, 1518.817741870975, 15890.52328430146, 15898.364065437383, 16603.252853621587, 16631.41790037349, 16633.417830375925, 16244.75632865508, 17010.82989170108, 17036.0, 17055.40306089287, 17082.145892705346, 2928.5899974003655, 2950.0707277207666, 2991.55126730991, 2997.0, 2997.310618557733, 2894.8263104213815, 2935.5156399194107, 2952.4537960477273, 2983.284011837165, 2994.625671791026, 2964.0, 2975.6577993530805, 3011.683773203815, 3021.6978302169828, 3025.5310426883866, 2894.305366711995, 2896.362800183956, 2924.239697678608, 2931.3551018775834, 3006.864691088906, 2882.3658795065053, 2918.3433727411375, 2923.3276346440225, 2931.457680329146, 2934.926626834325, 15566.688666226726, 15818.367265309489, 15867.365305387772, 15939.282732276959, 15942.20288985546, 8105.189481051848, 8376.246137847562, 8380.371472139614, 8385.454945428528, 8386.077531471534, 5252.842414727565, 5303.814366497154, 5433.1035379162395, 5484.012877682016, 5499.862503437406, 1810.1944634637591, 1813.9455816325399, 1822.635472905411, 1822.8723989320754, 1856.0997916010724, 27972.0, 28330.433391332263, 28345.71654283472, 28367.57448638272, 28368.432631347463, 6807.65961701913, 6892.862142757217, 7000.964995174992, 7087.964560177166, 7156.427485801123, 18587.25650973973, 18665.626687466447, 18666.440006799818, 18672.906635466737, 18682.06589670511, 8353.081161072278, 8418.326533877274, 8427.662893484314, 8462.111478294813, 8504.362172836938, 7809.80475488106, 7827.491213071132, 7939.0870049945, 7941.126476087626, 7954.204579542, 5216.895662086737, 5341.385740639798, 5432.674039557639, 5618.747156377891, 5678.233438485834, 1470.3236511204752, 1475.5057055886398, 1491.313995562032, 1510.939562417491, 1512.3345727879698, 909.2044461096541, 913.1690161952591, 916.0473107967772, 922.4419226368085, 924.7456949338986, 9215.354925155309, 9445.905540944503, 9475.431474111576, 9571.37786043905, 9609.087136722, 1041.3023274406166, 1064.180580952662, 1077.0844781935293, 1086.380762965118, 1099.384344766933, 5140.7943682253035, 5248.3701955765555, 5296.973515132399, 5469.453054694499, 6006.249218847644, 22855.20006799754, 23270.0, 23926.52146957086, 23932.52134957291, 23967.52064958726, 22549.549009019727, 22983.0, 23361.649575256386, 23374.415639609146, 23518.176863809684, 12676.619701408972, 12691.68270793256, 12896.0, 13061.673458163621, 13166.539171128965, 8607.48355098696, 8623.180797824196, 8644.91355086441, 8721.91278087211, 8740.91259087401, 20073.498162546053, 20179.0, 20542.17831286732, 20565.485862853548, 20802.375928722162, 20366.59266814685, 20473.0, 20666.586668266853, 20867.269645562334, 20963.895180524, 13254.469821207043, 13466.057375983588, 13603.387847546686, 13665.86334136646, 13746.65633359174, 13349.0, 13825.0, 15101.697966040398, 15301.387944482096, 15322.08067515908, 12133.150679452354, 12150.75698486043, 12316.445759940645, 12378.566750163702, 12561.309127998047, 11993.40032998364, 12096.939515302367, 12186.329751863732, 12304.81542776877, 12422.875771242172, 9930.801383972135, 10072.244581656552, 10114.797704046025, 10118.747031323981, 10123.949380253052, 7654.540727556142, 7664.961675191588, 7706.460547761827, 7790.844183116419, 7831.765047048598, 7014.824629384102, 7092.787216383516, 7154.463415243774, 7181.712731490682, 7191.676374563052], "value": 7132.909219037984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.2545174932717, 555.3419198250076, 559.5132234955589, 565.8019693107412, 570.3156212544947, 6196.876062478747, 6224.782132625359, 6232.5013998880095, 6237.376262373772, 6249.5000399968, 6130.957737184678, 6135.785247516338, 6142.692865356737, 6161.199044124269, 6168.136460895467, 4946.925796113062, 4947.208446648537, 4956.578690811276, 4989.501049895, 4989.875253118665, 4722.409698787652, 4852.320675105488, 4929.605631549467, 4930.728809915453, 4943.802247910079, 4754.786034628432, 4788.952110478903, 4798.568128868401, 4828.493008234138, 4829.661923665345, 4726.385569875912, 4756.571908528214, 4785.306130611077, 4786.449558300787, 4794.280857871312, 4321.978390108061, 4334.219840428722, 4372.3878656988045, 4388.0, 4405.185040767468, 5929.792457264019, 5941.940580594182, 5979.910301345483, 5990.64056156632, 6003.249593800775, 5686.071673088363, 5713.685747283897, 5752.309722833245, 5803.158542011427, 5812.779316343573, 6539.64031978241, 6548.476121910236, 6569.67151642416, 6571.835704107388, 6597.901031484532, 4950.257461380822, 4968.279599458095, 5000.74996250186, 5023.0, 5026.748662566857, 6614.536982411233, 6750.763723269711, 6758.966205169041, 6839.316068393171, 6850.21222559407, 5016.0, 5129.102407078821, 5130.333056702605, 5140.0, 5142.691438513626, 5194.584433245332, 5212.087884620252, 5218.63469557135, 5254.3169387979315, 5256.763445644955, 5808.448197421239, 5843.737031833492, 5851.61964472308, 5855.824325270249, 5860.912086318709, 6567.737290508326, 6567.770128045591, 6611.900821487681, 6660.234073081658, 6683.465322774166, 1768.9209582154874, 1780.8869456589632, 1784.5627821183894, 1786.7945186303741, 1787.4816303271905, 1225.209739717877, 1269.5239285268024, 1276.1513593460431, 1280.8398950131234, 1296.0, 6165.260168779685, 6173.41352571505, 6220.284667263322, 6303.653299068504, 6370.140031095835, 6573.0, 6616.503762217853, 6645.767398141042, 6674.028952773189, 6733.360330768569, 6045.848853778691, 6155.538334624921, 6236.656983865841, 6262.436380725757, 6279.3720627937755, 3541.327147841902, 3545.62770909056, 3547.8935631931085, 3563.893083207508, 3588.569371675416, 6618.536702430783, 6775.22084960226, 6777.423918966943, 6836.213835408892, 6887.552309099892, 6664.566803157779, 6843.213030501456, 6867.0, 6896.827579310558, 6922.896156557656, 6696.029075784081, 6698.330166983263, 6774.559653622498, 6793.448389578994, 6793.660316984131, 6556.409923106752, 6694.0, 6705.362990515893, 6790.777660021244, 6811.829704257433, 6582.637954912526, 6612.669366531751, 6615.503837212132, 6622.569532980341, 6625.0, 6801.387875091265, 6842.931570684428, 6850.623215722983, 6895.689693963684, 6951.548149370275, 5057.620678449204, 5063.822766203165, 5075.3148324975655, 5097.515736005073, 5137.486251374833, 6410.391012853772, 6578.605283682994, 6606.801795945937, 6729.798106056826, 6769.255381907888, 6374.872502550016, 6402.231732191981, 6458.7093580789915, 6498.350164983463, 6512.934870651233, 6407.551471397144, 6435.613863168225, 6505.0, 6517.706703198272, 6549.345065493412, 6432.09950606906, 6494.824233881703, 6524.67376631157, 6534.869302614016, 6537.607743535213, 6485.6108633482145, 6496.577722448214, 6584.868302634016, 6587.670616469253, 6617.371349721769, 6263.467605253422, 6326.55714100027, 6333.714982825692, 6409.647469389042, 6485.124508191334], "value": 5104.941392396431, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [950.4819873169117, 966.6230170233608, 975.1516180922598, 989.2531138990062, 997.3018886779251, 16808.243629036693, 17190.91404542977, 17204.82795172048, 17572.56068598286, 17869.7319540207, 19699.901500492513, 19766.20935162592, 19836.504087397785, 19862.0, 19864.304749333776, 1064.2284343850686, 1071.4000159910436, 1109.6227282723871, 1116.13499537858, 1117.4245263689206, 1061.3048453263125, 1108.2851560743316, 1109.0905457524832, 1110.3448965110583, 1111.6776134920863, 1144.3991904250292, 1155.2721785275307, 1159.5999380213814, 1160.0371691496039, 1160.0661467518687, 1138.3852719531444, 1150.177622999551, 1151.6257216404701, 1155.2548606148987, 1158.1314014489133, 831.9584020798997, 841.0538144587339, 846.5978660136448, 850.3919697416316, 853.2747164909777, 18173.909130454264, 18487.630247394976, 18531.0, 18540.536486587807, 19220.903895480573, 21134.365969020953, 21236.044378003025, 21564.56870862574, 21621.567568648537, 21691.240806571852, 16257.51227463178, 16357.509274721777, 16381.590460238589, 16393.34426622934, 16556.089415082166, 3790.8673196437994, 3804.1821008483034, 3804.2391521695495, 3810.161764411825, 3813.675837553811, 136912.0, 137399.0, 137525.0, 138884.0, 145686.0, 16772.245248963827, 17439.912800435915, 17957.371491997717, 17965.191566379544, 17991.190396432194, 32687.83656081752, 32815.0, 32921.83539082337, 32926.17684557905, 33073.3385332292, 9173.174414302744, 9198.356115072014, 9496.620135194653, 9515.857262141073, 9567.952160239294, 4575.405197324327, 4605.125026245003, 4613.861584152413, 4635.629149668019, 4657.720536767804, 5896.292444906553, 5995.820125396158, 6023.759049638053, 6027.246594175728, 6038.275406951194, 1051.9211059170593, 1091.7980173667897, 1099.3074363151322, 1106.2256420505678, 1108.3626914524182, 698.9091418115714, 728.8360118973188, 731.184729027131, 743.7099531182843, 757.246539693009, 12556.937215313865, 13285.468581256642, 13804.240766757925, 13953.581392558239, 14007.789883151761, 679.1341040173719, 694.3611877073105, 703.954242974205, 707.6214225389392, 708.0123228096776, 5893.44012318829, 5958.0, 6051.909221361683, 6162.0, 6162.014077747628, 122880.0, 123219.0, 125292.0, 126083.36958315149, 126377.36811315885, 113164.0, 113214.43392783149, 113339.0, 114935.0, 117853.0, 97077.0, 99179.99999999856, 99195.0, 99583.50208248913, 100141.49929250307, 12028.15802893824, 12048.156629035884, 12095.637130886087, 12150.149489535648, 12345.691357716129, 48041.0, 48374.75812620914, 49592.0, 51536.0, 52350.0, 87142.0, 87332.0, 88247.55876220578, 88755.0, 94485.0, 19300.0, 20438.28466003683, 20468.897655511628, 20865.89567052155, 20873.89563052175, 22323.330300091024, 22797.088116475155, 23095.538089237783, 23530.411739706644, 24776.876115619307, 20886.164553417693, 21955.451113722283, 21978.120875164816, 22123.225687100876, 22163.1134754608, 22331.10675572959, 22387.44031399228, 22580.435489112904, 22658.886705566365, 23180.072797087927, 20466.488337791674, 21133.89433052825, 21218.681719774526, 21560.67658985148, 21758.12967481283, 13599.116057456235, 13791.586252412444, 13858.584242472742, 13863.86136138666, 14000.649983750487, 15602.0, 15737.213139342759, 16317.0, 16532.173391330627, 16540.090295033406], "value": 9978.618423672286, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 107.0, 100.0, 105.0, 106.0, 107.0, 107.0, 98.0, 106.0, 108.0], "value": 104.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 112.0, 146.0, 172.0, 114.0, 146.0, 137.0, 119.0, 155.0, 114.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 163.0, 161.0, 162.0, 161.0, 161.0, 163.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 178.0, 74.0, 76.0, 75.0, 75.0, 159.0, 75.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 126.0, 77.0, 78.0, 78.0, 130.0, 87.0, 77.0, 132.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 113.0, 116.0, 113.0, 113.0, 113.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 150.0, 148.0, 148.0, 148.0, 149.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 100.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 45.0, 49.0, 45.0, 45.0, 52.0, 48.0, 44.0, 44.0, 44.0], "value": 46.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 52.0, 52.0, 51.0, 52.0, 52.0, 51.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 73.0, 73.0, 76.0, 74.0, 72.0, 74.0, 79.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 123.0, 112.0, 116.0, 114.0, 113.0, 112.0, 129.0, 138.0], "value": 118.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 162.0, 164.0, 161.0, 162.0, 162.0, 158.0, 166.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 67.0, 60.0, 62.0, 60.0, 58.0, 58.0, 56.0, 60.0, 58.0], "value": 59.9, "unit": "score"}]}]} 05:27:49 INFO - Return code: 0 05:27:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:27:50 INFO - # TBPL SUCCESS # 05:27:50 INFO - Running post-action listener: _package_coverage_data 05:27:50 INFO - Running post-action listener: _resource_record_post_action 05:27:50 INFO - [mozharness: 2017-08-02 12:27:50.044018Z] Finished run-tests step (success) 05:27:50 INFO - Running post-run listener: _resource_record_post_run 05:27:50 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 5361664; Write bytes: 391360512; Read time: 1172; Write time: 364760 05:27:50 INFO - TinderboxPrint: CPU usage
13.0% 05:27:50 INFO - TinderboxPrint: I/O read bytes / time
5,361,664 / 1,172 05:27:50 INFO - TinderboxPrint: I/O write bytes / time
391,360,512 / 364,760 05:27:50 INFO - TinderboxPrint: CPU idle
8,217.5 (87.0%) 05:27:50 INFO - TinderboxPrint: CPU user
1,180.8 (12.5%) 05:27:50 INFO - TinderboxPrint: Swap in / out
0 / 0 05:27:50 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 112087040; Read time: 0; Write time: 151456 05:27:50 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:27:50 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 3125248; Write bytes: 279273472; Read time: 936; Write time: 213304 05:27:50 INFO - Running post-run listener: _upload_blobber_files 05:27:50 INFO - Blob upload gear active. 05:27:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:27:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:27:50 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:27:50 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:27:51 INFO - (blobuploader) - INFO - Open directory for files ... 05:27:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:27:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:27:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:51 INFO - (blobuploader) - INFO - Done attempting. 05:27:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:27:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:27:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:52 INFO - (blobuploader) - INFO - Done attempting. 05:27:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:27:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:27:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:53 INFO - (blobuploader) - INFO - Done attempting. 05:27:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:27:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:28:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:00 INFO - (blobuploader) - INFO - Done attempting. 05:28:00 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:00 INFO - Return code: 0 05:28:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/01d2956b2076830b214f4f1797c8f552d0a78d38f306c3c0e90f45138d8c3093517f29ea388e3d49b8647dd655078be94c1cb1136d7a11a2494bd7f89378b5e6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f21e4233b9f08264d3a5b6c9d2591cf6be3076c5ab2e9d1f8b9a2440199d8edfff19c6d2cf3ca529a2f464d093a65ca8e5944383d16f61f351a2c04632007294", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/13c3f9bd53ca459a31d92687ca13e76bed934d3c44639048a2b9de76cb47371e69698ef6c5820a14e51648b392e8b2ff5478cd4107578b58269d2ca233f28d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/37d7b133488747bb2856c2f3f89a46884789a33c88d34e98f75aaae33342ffeb7026227dbc4030a57b31dd141b5aaf97e3cde76cdf306e107156c9ea8e9f5f81"} 05:28:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:00 INFO - Contents: 05:28:00 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/01d2956b2076830b214f4f1797c8f552d0a78d38f306c3c0e90f45138d8c3093517f29ea388e3d49b8647dd655078be94c1cb1136d7a11a2494bd7f89378b5e6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f21e4233b9f08264d3a5b6c9d2591cf6be3076c5ab2e9d1f8b9a2440199d8edfff19c6d2cf3ca529a2f464d093a65ca8e5944383d16f61f351a2c04632007294", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/13c3f9bd53ca459a31d92687ca13e76bed934d3c44639048a2b9de76cb47371e69698ef6c5820a14e51648b392e8b2ff5478cd4107578b58269d2ca233f28d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/37d7b133488747bb2856c2f3f89a46884789a33c88d34e98f75aaae33342ffeb7026227dbc4030a57b31dd141b5aaf97e3cde76cdf306e107156c9ea8e9f5f81"} 05:28:00 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:00 INFO - Copying logs to upload dir... 05:28:00 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.511833 ========= master_lag: -0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-02 05:27:59.947611) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 05:27:59.952352) ========= 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=ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/01d2956b2076830b214f4f1797c8f552d0a78d38f306c3c0e90f45138d8c3093517f29ea388e3d49b8647dd655078be94c1cb1136d7a11a2494bd7f89378b5e6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f21e4233b9f08264d3a5b6c9d2591cf6be3076c5ab2e9d1f8b9a2440199d8edfff19c6d2cf3ca529a2f464d093a65ca8e5944383d16f61f351a2c04632007294", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/13c3f9bd53ca459a31d92687ca13e76bed934d3c44639048a2b9de76cb47371e69698ef6c5820a14e51648b392e8b2ff5478cd4107578b58269d2ca233f28d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/37d7b133488747bb2856c2f3f89a46884789a33c88d34e98f75aaae33342ffeb7026227dbc4030a57b31dd141b5aaf97e3cde76cdf306e107156c9ea8e9f5f81"} build_url:https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011218 build_url: 'https://queue.taskcluster.net/v1/task/YQiLO3_NSbK9rIPSloJRkw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/01d2956b2076830b214f4f1797c8f552d0a78d38f306c3c0e90f45138d8c3093517f29ea388e3d49b8647dd655078be94c1cb1136d7a11a2494bd7f89378b5e6", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f21e4233b9f08264d3a5b6c9d2591cf6be3076c5ab2e9d1f8b9a2440199d8edfff19c6d2cf3ca529a2f464d093a65ca8e5944383d16f61f351a2c04632007294", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/13c3f9bd53ca459a31d92687ca13e76bed934d3c44639048a2b9de76cb47371e69698ef6c5820a14e51648b392e8b2ff5478cd4107578b58269d2ca233f28d28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/37d7b133488747bb2856c2f3f89a46884789a33c88d34e98f75aaae33342ffeb7026227dbc4030a57b31dd141b5aaf97e3cde76cdf306e107156c9ea8e9f5f81"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 05:27:59.981014) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 05:27:59.981300) ========= 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=ba164b0a7b0ec7655860e956000001c1-1501668399.428036-1998242046 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 05:28:00.032471) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 05:28:00.032753) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 05:28:00.034224) ========= ========= Total master_lag: 0.01 =========