builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1502317136.75 results: success (0) revision: 7f9c0489c233d437b23f2810c80b383f59106de5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 15:18:56.750367) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 15:18:56.750819) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 15:18:56.751125) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 15:18:56.938908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 15:18:56.939241) ========= 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=836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-09 15:18:57-- 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% 227M=0s 2017-08-09 15:18:57 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.239687 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 15:18:57.192825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 15:18:57.193139) ========= 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=836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022986 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 15:18:57.253486) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-08-09 15:18:57.253876) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7f9c0489c233d437b23f2810c80b383f59106de5 --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 7f9c0489c233d437b23f2810c80b383f59106de5 --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=836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-09 15:18:57,626 truncating revision to first 12 chars 2017-08-09 15:18:57,626 Setting DEBUG logging. 2017-08-09 15:18:57,626 attempt 1/10 2017-08-09 15:18:57,626 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7f9c0489c233?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-09 15:19:01,067 unpacking tar archive at: mozilla-beta-7f9c0489c233/testing/mozharness/ program finished with exit code 0 elapsedTime=3.776685 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-08-09 15:19:01.070844) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 15:19:01.071231) ========= script_repo_revision: 7f9c0489c233d437b23f2810c80b383f59106de5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 15:19:01.071646) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 15:19:01.071931) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 15:19:01.083135) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-08-09 15:19:01.083716) ========= /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=836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:19:01 INFO - MultiFileLogger online at 20170809 15:19:01 in /builds/slave/test 15:19:01 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 15:19:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:19:01 INFO - {'append_to_log': False, 15:19:01 INFO - 'base_work_dir': '/builds/slave/test', 15:19:01 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 15:19:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:19:01 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 15:19:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:19:01 INFO - 'code_coverage': False, 15:19:01 INFO - 'config_files': ('talos/linux_config.py',), 15:19:01 INFO - 'default_actions': ('clobber', 15:19:01 INFO - 'read-buildbot-config', 15:19:01 INFO - 'download-and-extract', 15:19:01 INFO - 'populate-webroot', 15:19:01 INFO - 'create-virtualenv', 15:19:01 INFO - 'install', 15:19:01 INFO - 'setup-mitmproxy', 15:19:01 INFO - 'run-tests'), 15:19:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:19:01 INFO - 'disable_ccov_upload': False, 15:19:01 INFO - 'download_minidump_stackwalk': True, 15:19:01 INFO - 'download_symbols': 'ondemand', 15:19:01 INFO - 'enable_stylo': False, 15:19:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:19:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:19:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:19:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:19:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:19:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:19:01 INFO - 'gecko_profile': False, 15:19:01 INFO - 'gecko_profile_interval': 0, 15:19:01 INFO - 'installer_path': 'installer.exe', 15:19:01 INFO - 'log_level': 'info', 15:19:01 INFO - 'log_name': 'talos', 15:19:01 INFO - 'log_to_console': True, 15:19:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:19:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:19:01 INFO - 'opt_config_files': (), 15:19:01 INFO - 'pip_index': False, 15:19:01 INFO - 'suite': 'dromaeojs-e10s', 15:19:01 INFO - 'system_bits': '32', 15:19:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:19:01 INFO - 'title': 'talos-linux64-ix-028', 15:19:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:19:01 INFO - 'use_talos_json': True, 15:19:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:19:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:19:01 INFO - 'work_dir': 'build'} 15:19:01 INFO - [mozharness: 2017-08-09 22:19:01.539417Z] Running clobber step. 15:19:01 INFO - Running pre-action listener: _resource_record_pre_action 15:19:01 INFO - Running main action method: clobber 15:19:01 INFO - rmtree: /builds/slave/test/build 15:19:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:19:02 INFO - Running post-action listener: _resource_record_post_action 15:19:02 INFO - [mozharness: 2017-08-09 22:19:02.636713Z] Finished clobber step (success) 15:19:02 INFO - [mozharness: 2017-08-09 22:19:02.636816Z] Running read-buildbot-config step. 15:19:02 INFO - Running pre-action listener: _resource_record_pre_action 15:19:02 INFO - Running main action method: read_buildbot_config 15:19:02 INFO - Using buildbot properties: 15:19:02 INFO - { 15:19:02 INFO - "project": "", 15:19:02 INFO - "product": "firefox", 15:19:02 INFO - "who": "ryanvm@gmail.com", 15:19:02 INFO - "installer_path": "public/build/target.tar.bz2", 15:19:02 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 15:19:02 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 15:19:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 15:19:02 INFO - "stage_platform": "linux64", 15:19:02 INFO - "basedir": "/builds/slave/test", 15:19:02 INFO - "buildnumber": 43, 15:19:02 INFO - "platform": "ubuntu64_hw", 15:19:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:19:02 INFO - "slavebuilddir": "test", 15:19:02 INFO - "taskId": "XtaCOzjaR0OzJokzcht_jQ", 15:19:02 INFO - "branch": "mozilla-beta", 15:19:02 INFO - "script_repo_revision": "production", 15:19:02 INFO - "revision": "7f9c0489c233d437b23f2810c80b383f59106de5", 15:19:02 INFO - "slavename": "talos-linux64-ix-028", 15:19:02 INFO - "repo_path": "releases/mozilla-beta" 15:19:02 INFO - } 15:19:02 INFO - Finding installer, test and symbols from parent task. 15:19:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XtaCOzjaR0OzJokzcht_jQ'}, attempt #1 15:19:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XtaCOzjaR0OzJokzcht_jQ'}, attempt #1 15:19:03 INFO - Task dependencies: T0v6dT-NQJCPoWIEJ0-MGA 15:19:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA'}, attempt #1 15:19:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.tar.bz2 15:19:04 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.test_packages.json 15:19:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.crashreporter-symbols.zip 15:19:04 INFO - Running post-action listener: _resource_record_post_action 15:19:04 INFO - [mozharness: 2017-08-09 22:19:04.100936Z] Finished read-buildbot-config step (success) 15:19:04 INFO - [mozharness: 2017-08-09 22:19:04.101161Z] Running download-and-extract step. 15:19:04 INFO - Running pre-action listener: _resource_record_pre_action 15:19:04 INFO - Running main action method: download_and_extract 15:19:04 INFO - mkdir: /builds/slave/test/build/tests 15:19: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')]} 15:19:04 INFO - trying https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.test_packages.json 15:19:04 INFO - Downloading https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:19:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:19:04 INFO - Downloaded 989 bytes. 15:19:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:19:04 INFO - Using the following test package requirements: 15:19:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:19:04 INFO - u'common': [u'target.common.tests.zip'], 15:19:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:19:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:19:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:19:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:19:04 INFO - u'mozbase': [u'target.common.tests.zip'], 15:19:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:19:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:19:04 INFO - u'web-platform': [u'target.common.tests.zip', 15:19:04 INFO - u'target.web-platform.tests.tar.gz'], 15:19:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:19:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:19:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.common.tests.zip 15:19:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:19:04 INFO - Fetch https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.common.tests.zip into memory 15:19:05 INFO - Content-Length response header: 72820434 15:19:05 INFO - Bytes received: 72820434 15:19:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:19:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.common.tests.zip 15:19:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:19:17 INFO - Fetch https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.common.tests.zip into memory 15:19:18 INFO - Content-Length response header: 72820434 15:19:18 INFO - Bytes received: 72820434 15:19:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.talos.tests.zip 15:19:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:19:32 INFO - Fetch https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.talos.tests.zip into memory 15:19:33 INFO - Content-Length response header: 14496472 15:19:33 INFO - Bytes received: 14496472 15:19:33 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')]} 15:19:33 INFO - trying https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.tar.bz2 15:19:33 INFO - Downloading https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:19:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:19:34 INFO - Downloaded 53619670 bytes. 15:19:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.tar.bz2 15:19:34 INFO - mkdir: /builds/slave/test/properties 15:19:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:19:34 INFO - Writing to file /builds/slave/test/properties/build_url 15:19:34 INFO - Contents: 15:19:34 INFO - build_url:https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.tar.bz2 15:19:34 INFO - Running post-action listener: _resource_record_post_action 15:19:34 INFO - Running post-action listener: set_extra_try_arguments 15:19:34 INFO - [mozharness: 2017-08-09 22:19:34.586554Z] Finished download-and-extract step (success) 15:19:34 INFO - [mozharness: 2017-08-09 22:19:34.586651Z] Running populate-webroot step. 15:19:34 INFO - Running pre-action listener: _resource_record_pre_action 15:19:34 INFO - Running main action method: populate_webroot 15:19:34 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:19:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:19:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:19:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:19:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:19:34 INFO - 'tests': ['damp', 'tps']}, 15:19:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:19:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:19:34 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:19:34 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:19:34 INFO - 'other-e10s': {'tests': ['a11yr', 15:19:34 INFO - 'ts_paint', 15:19:34 INFO - 'tpaint', 15:19:34 INFO - 'sessionrestore', 15:19:34 INFO - 'sessionrestore_many_windows', 15:19:34 INFO - 'sessionrestore_no_auto_restore', 15:19:34 INFO - 'tabpaint']}, 15:19:34 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:19:34 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:19:34 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:19:34 INFO - 'talos_options': ['--mitmproxy', 15:19:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:19:34 INFO - '--firstNonBlankPaint'], 15:19:34 INFO - 'tests': ['quantum_pageload_google', 15:19:34 INFO - 'quantum_pageload_youtube', 15:19:34 INFO - 'quantum_pageload_amazon', 15:19:34 INFO - 'quantum_pageload_facebook']}, 15:19:34 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:19:34 INFO - 'talos_options': ['--stylo', 15:19:34 INFO - '--mitmproxy', 15:19:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:19:34 INFO - '--firstNonBlankPaint'], 15:19:34 INFO - 'tests': ['quantum_pageload_google', 15:19:34 INFO - 'quantum_pageload_youtube', 15:19:34 INFO - 'quantum_pageload_amazon', 15:19:34 INFO - 'quantum_pageload_facebook']}, 15:19:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:19:34 INFO - 'tsvgr_opacity', 15:19:34 INFO - 'tart', 15:19:34 INFO - 'tscrollx', 15:19:34 INFO - 'cart', 15:19:34 INFO - 'tsvg_static']}, 15:19:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:19:34 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:19:34 INFO - 'talos_options': ['--stylo', 15:19:34 INFO - '--stylo-threads=1', 15:19:34 INFO - '--mitmproxy', 15:19:34 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:19:34 INFO - '--firstNonBlankPaint'], 15:19:34 INFO - 'tests': ['tp6_google', 15:19:34 INFO - 'tp6_youtube', 15:19:34 INFO - 'tp6_amazon', 15:19:34 INFO - 'tp6_facebook']}, 15:19:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:19:34 INFO - 'talos_options': ['--xperf_path', 15:19:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:19:34 INFO - 'tests': ['tp5n']}}} 15:19:34 INFO - Running post-action listener: _resource_record_post_action 15:19:34 INFO - [mozharness: 2017-08-09 22:19:34.595294Z] Finished populate-webroot step (success) 15:19:34 INFO - [mozharness: 2017-08-09 22:19:34.595384Z] Running create-virtualenv step. 15:19:34 INFO - Running pre-action listener: _resource_record_pre_action 15:19:34 INFO - Running main action method: create_virtualenv 15:19:34 INFO - Creating virtualenv /builds/slave/test/build/venv 15:19:34 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 15:19:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:19:34 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:19:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:19:34 INFO - Using real prefix '/usr' 15:19:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:19:35 INFO - Installing distribute.............................................................................................................................................................................................done. 15:19:37 INFO - Installing pip.................done. 15:19:37 INFO - Return code: 0 15:19:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:19:37 INFO - Reading from file tmpfile_stdout 15:19:37 INFO - Output received: 15:19:37 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) 15:19:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd46eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd44050>, '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 0xd44f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd453e0>, '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': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', '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 15:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:19:37 INFO - Using env: {'DISPLAY': ':0', 15:19:37 INFO - 'HOME': '/home/cltbld', 15:19:37 INFO - 'LANG': 'en_US.UTF-8', 15:19:37 INFO - 'LANGUAGE': 'en_US:en', 15:19:37 INFO - 'LOGNAME': 'cltbld', 15:19:37 INFO - 'MAIL': '/var/mail/cltbld', 15:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:37 INFO - 'MOZ_NO_REMOTE': '1', 15:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:37 INFO - 'NO_EM_RESTART': '1', 15:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:37 INFO - 'PWD': '/builds/slave/test', 15:19:37 INFO - 'SHELL': '/bin/bash', 15:19:37 INFO - 'SHLVL': '1', 15:19:37 INFO - 'TERM': 'linux', 15:19:37 INFO - 'TMOUT': '86400', 15:19:37 INFO - 'USER': 'cltbld', 15:19:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', 15:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:37 INFO - '_': '/tools/buildbot/bin/python'} 15:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:37 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 15:19:37 INFO - Cleaning up... 15:19:37 INFO - Return code: 0 15:19:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x9d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd46eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd44050>, '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 0xd44f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd453e0>, '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': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', '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 15:19:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:19:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:19:37 INFO - Using env: {'DISPLAY': ':0', 15:19:37 INFO - 'HOME': '/home/cltbld', 15:19:37 INFO - 'LANG': 'en_US.UTF-8', 15:19:37 INFO - 'LANGUAGE': 'en_US:en', 15:19:37 INFO - 'LOGNAME': 'cltbld', 15:19:37 INFO - 'MAIL': '/var/mail/cltbld', 15:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:37 INFO - 'MOZ_NO_REMOTE': '1', 15:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:37 INFO - 'NO_EM_RESTART': '1', 15:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:37 INFO - 'PWD': '/builds/slave/test', 15:19:37 INFO - 'SHELL': '/bin/bash', 15:19:37 INFO - 'SHLVL': '1', 15:19:37 INFO - 'TERM': 'linux', 15:19:37 INFO - 'TMOUT': '86400', 15:19:37 INFO - 'USER': 'cltbld', 15:19:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', 15:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:37 INFO - '_': '/tools/buildbot/bin/python'} 15:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:37 INFO - Downloading/unpacking psutil>=3.1.1 15:19:37 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 15:19:37 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 15:19:37 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 15:19:37 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 15:19:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:19:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:39 INFO - Installing collected packages: psutil 15:19:39 INFO - Running setup.py install for psutil 15:19:39 INFO - building 'psutil._psutil_linux' extension 15:19:39 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 15:19:39 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 15:19:39 INFO - building 'psutil._psutil_posix' extension 15:19:39 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 15:19:39 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 15:19:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:19:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:19:39 INFO - Successfully installed psutil 15:19:39 INFO - Cleaning up... 15:19:39 INFO - Return code: 0 15:19:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:19:39 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')]} 15:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:39 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')]} 15:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:39 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 0x9d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd46eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd44050>, '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 0xd44f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd453e0>, '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': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', '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 15:19:39 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 15:19:39 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 15:19:39 INFO - Using env: {'DISPLAY': ':0', 15:19:39 INFO - 'HOME': '/home/cltbld', 15:19:39 INFO - 'LANG': 'en_US.UTF-8', 15:19:39 INFO - 'LANGUAGE': 'en_US:en', 15:19:39 INFO - 'LOGNAME': 'cltbld', 15:19:39 INFO - 'MAIL': '/var/mail/cltbld', 15:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:39 INFO - 'MOZ_NO_REMOTE': '1', 15:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:39 INFO - 'NO_EM_RESTART': '1', 15:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:39 INFO - 'PWD': '/builds/slave/test', 15:19:39 INFO - 'SHELL': '/bin/bash', 15:19:39 INFO - 'SHLVL': '1', 15:19:39 INFO - 'TERM': 'linux', 15:19:39 INFO - 'TMOUT': '86400', 15:19:39 INFO - 'USER': 'cltbld', 15:19:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', 15:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:39 INFO - '_': '/tools/buildbot/bin/python'} 15:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:19:39 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 15:19:39 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 15:19:39 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 15:19:39 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 15:19:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:19:40 INFO - Installing collected packages: mozsystemmonitor 15:19:40 INFO - Running setup.py install for mozsystemmonitor 15:19:40 INFO - Successfully installed mozsystemmonitor 15:19:40 INFO - Cleaning up... 15:19:41 INFO - Return code: 0 15:19:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:19:41 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')]} 15:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:41 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')]} 15:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:41 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 0x9d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd46eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd44050>, '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 0xd44f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd453e0>, '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': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', '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 15:19:41 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 15:19:41 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 15:19:41 INFO - Using env: {'DISPLAY': ':0', 15:19:41 INFO - 'HOME': '/home/cltbld', 15:19:41 INFO - 'LANG': 'en_US.UTF-8', 15:19:41 INFO - 'LANGUAGE': 'en_US:en', 15:19:41 INFO - 'LOGNAME': 'cltbld', 15:19:41 INFO - 'MAIL': '/var/mail/cltbld', 15:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:41 INFO - 'MOZ_NO_REMOTE': '1', 15:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:41 INFO - 'NO_EM_RESTART': '1', 15:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:41 INFO - 'PWD': '/builds/slave/test', 15:19:41 INFO - 'SHELL': '/bin/bash', 15:19:41 INFO - 'SHLVL': '1', 15:19:41 INFO - 'TERM': 'linux', 15:19:41 INFO - 'TMOUT': '86400', 15:19:41 INFO - 'USER': 'cltbld', 15:19:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', 15:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:41 INFO - '_': '/tools/buildbot/bin/python'} 15:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:41 INFO - Downloading/unpacking jsonschema==2.5.1 15:19:41 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 15:19:41 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 15:19:41 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 15:19:41 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 15:19:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:19:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:19:42 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 15:19:42 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 15:19:42 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 15:19:42 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 15:19:42 INFO - Downloading functools32-3.2.3-2.tar.gz 15:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:19:42 INFO - warning: no files found matching '*.txt' 15:19:42 INFO - no previously-included directories found matching 'build' 15:19:42 INFO - no previously-included directories found matching 'dist' 15:19:42 INFO - no previously-included directories found matching '.git*' 15:19:42 INFO - Installing collected packages: jsonschema, functools32 15:19:42 INFO - Running setup.py install for functools32 15:19:42 INFO - warning: no files found matching '*.txt' 15:19:42 INFO - no previously-included directories found matching 'build' 15:19:42 INFO - no previously-included directories found matching 'dist' 15:19:42 INFO - no previously-included directories found matching '.git*' 15:19:42 INFO - Successfully installed jsonschema functools32 15:19:42 INFO - Cleaning up... 15:19:42 INFO - Return code: 0 15:19:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19: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')]} 15:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x9d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd46eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd44050>, '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 0xd44f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd453e0>, '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': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', '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 15:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:19:42 INFO - Using env: {'DISPLAY': ':0', 15:19:42 INFO - 'HOME': '/home/cltbld', 15:19:42 INFO - 'LANG': 'en_US.UTF-8', 15:19:42 INFO - 'LANGUAGE': 'en_US:en', 15:19:42 INFO - 'LOGNAME': 'cltbld', 15:19:42 INFO - 'MAIL': '/var/mail/cltbld', 15:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:42 INFO - 'MOZ_NO_REMOTE': '1', 15:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:42 INFO - 'NO_EM_RESTART': '1', 15:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:42 INFO - 'PWD': '/builds/slave/test', 15:19:42 INFO - 'SHELL': '/bin/bash', 15:19:42 INFO - 'SHLVL': '1', 15:19:42 INFO - 'TERM': 'linux', 15:19:42 INFO - 'TMOUT': '86400', 15:19:42 INFO - 'USER': 'cltbld', 15:19:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', 15:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:42 INFO - '_': '/tools/buildbot/bin/python'} 15:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:19:42 INFO - Cleaning up... 15:19:42 INFO - Return code: 0 15:19:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19: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')]} 15:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x9d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd46eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd44050>, '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 0xd44f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd453e0>, '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': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', '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 15:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:19:42 INFO - Using env: {'DISPLAY': ':0', 15:19:42 INFO - 'HOME': '/home/cltbld', 15:19:42 INFO - 'LANG': 'en_US.UTF-8', 15:19:42 INFO - 'LANGUAGE': 'en_US:en', 15:19:42 INFO - 'LOGNAME': 'cltbld', 15:19:42 INFO - 'MAIL': '/var/mail/cltbld', 15:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:42 INFO - 'MOZ_NO_REMOTE': '1', 15:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:42 INFO - 'NO_EM_RESTART': '1', 15:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:42 INFO - 'PWD': '/builds/slave/test', 15:19:42 INFO - 'SHELL': '/bin/bash', 15:19:42 INFO - 'SHLVL': '1', 15:19:42 INFO - 'TERM': 'linux', 15:19:42 INFO - 'TMOUT': '86400', 15:19:42 INFO - 'USER': 'cltbld', 15:19:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', 15:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:42 INFO - '_': '/tools/buildbot/bin/python'} 15:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:43 INFO - Downloading/unpacking blobuploader==1.2.4 15:19:43 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 15:19:43 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 15:19:43 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 15:19:43 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 15:19:44 INFO - Downloading blobuploader-1.2.4.tar.gz 15:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:19:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:19:44 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 15:19:44 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 15:19:44 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 15:19:44 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 15:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:19:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:19:44 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 15:19:44 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 15:19:44 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 15:19:44 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 15:19:44 INFO - Downloading docopt-0.6.1.tar.gz 15:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:19:44 INFO - Installing collected packages: blobuploader, requests, docopt 15:19:44 INFO - Running setup.py install for blobuploader 15:19:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:19:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:19:44 INFO - Running setup.py install for requests 15:19:45 INFO - Running setup.py install for docopt 15:19:45 INFO - Successfully installed blobuploader requests docopt 15:19:45 INFO - Cleaning up... 15:19:45 INFO - Return code: 0 15:19:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:45 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')]} 15:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:45 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')]} 15:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:45 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 0x9d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd46eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd44050>, '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 0xd44f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd453e0>, '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': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', '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 15:19:45 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 15:19:45 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 15:19:45 INFO - Using env: {'DISPLAY': ':0', 15:19:45 INFO - 'HOME': '/home/cltbld', 15:19:45 INFO - 'LANG': 'en_US.UTF-8', 15:19:45 INFO - 'LANGUAGE': 'en_US:en', 15:19:45 INFO - 'LOGNAME': 'cltbld', 15:19:45 INFO - 'MAIL': '/var/mail/cltbld', 15:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:45 INFO - 'MOZ_NO_REMOTE': '1', 15:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:45 INFO - 'NO_EM_RESTART': '1', 15:19:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:45 INFO - 'PWD': '/builds/slave/test', 15:19:45 INFO - 'SHELL': '/bin/bash', 15:19:45 INFO - 'SHLVL': '1', 15:19:45 INFO - 'TERM': 'linux', 15:19:45 INFO - 'TMOUT': '86400', 15:19:45 INFO - 'USER': 'cltbld', 15:19:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', 15:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:45 INFO - '_': '/tools/buildbot/bin/python'} 15:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:45 INFO - Running setup.py (path:/tmp/pip-etfjfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:45 INFO - Running setup.py (path:/tmp/pip-g4KnY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:45 INFO - Running setup.py (path:/tmp/pip-e6oA30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:45 INFO - Running setup.py (path:/tmp/pip-DbLxc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:45 INFO - Running setup.py (path:/tmp/pip-PZthGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:46 INFO - Running setup.py (path:/tmp/pip-5TQRms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:46 INFO - Running setup.py (path:/tmp/pip-Q1xlE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:46 INFO - Running setup.py (path:/tmp/pip-Fx9gKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:46 INFO - Running setup.py (path:/tmp/pip-nmL12w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:46 INFO - Running setup.py (path:/tmp/pip-p_YnsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:46 INFO - Running setup.py (path:/tmp/pip-PPNFs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:46 INFO - Running setup.py (path:/tmp/pip-6kloO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:46 INFO - Running setup.py (path:/tmp/pip-jZnuwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:46 INFO - Running setup.py (path:/tmp/pip-5vEytl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:46 INFO - Running setup.py (path:/tmp/pip-M8ACQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:46 INFO - Running setup.py (path:/tmp/pip-KLxNu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:46 INFO - Running setup.py (path:/tmp/pip-UnNUd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:19:46 INFO - Running setup.py install for manifestparser 15:19:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:19:47 INFO - Running setup.py install for mozcrash 15:19:47 INFO - Running setup.py install for mozdebug 15:19:47 INFO - Running setup.py install for mozdevice 15:19:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:19:47 INFO - Running setup.py install for mozfile 15:19:47 INFO - Running setup.py install for mozhttpd 15:19:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:19:47 INFO - Running setup.py install for mozinfo 15:19:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:19:47 INFO - Running setup.py install for mozInstall 15:19:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:19:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:19:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:19:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:19:47 INFO - Running setup.py install for mozleak 15:19:47 INFO - Running setup.py install for mozlog 15:19:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:19:47 INFO - Running setup.py install for moznetwork 15:19:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:19:48 INFO - Running setup.py install for mozprocess 15:19:48 INFO - Running setup.py install for mozprofile 15:19:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:19:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:19:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:19:48 INFO - Running setup.py install for mozrunner 15:19:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:19:48 INFO - Running setup.py install for mozscreenshot 15:19:48 INFO - Running setup.py install for moztest 15:19:48 INFO - Running setup.py install for mozversion 15:19:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:19:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:19:48 INFO - Cleaning up... 15:19:48 INFO - Return code: 0 15:19:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19:48 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')]} 15:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:48 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')]} 15:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:48 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 0x9d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd46eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd44050>, '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 0xd44f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd453e0>, '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': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', '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 15:19:48 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 15:19:48 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 15:19:48 INFO - Using env: {'DISPLAY': ':0', 15:19:48 INFO - 'HOME': '/home/cltbld', 15:19:48 INFO - 'LANG': 'en_US.UTF-8', 15:19:48 INFO - 'LANGUAGE': 'en_US:en', 15:19:48 INFO - 'LOGNAME': 'cltbld', 15:19:48 INFO - 'MAIL': '/var/mail/cltbld', 15:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:48 INFO - 'MOZ_NO_REMOTE': '1', 15:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:48 INFO - 'NO_EM_RESTART': '1', 15:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:48 INFO - 'PWD': '/builds/slave/test', 15:19:48 INFO - 'SHELL': '/bin/bash', 15:19:48 INFO - 'SHLVL': '1', 15:19:48 INFO - 'TERM': 'linux', 15:19:48 INFO - 'TMOUT': '86400', 15:19:48 INFO - 'USER': 'cltbld', 15:19:48 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', 15:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:48 INFO - '_': '/tools/buildbot/bin/python'} 15:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:19:48 INFO - Running setup.py (path:/tmp/pip-jz_9Gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:19:48 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)) 15:19:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:19:49 INFO - Running setup.py (path:/tmp/pip-590tOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:19:49 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)) 15:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:19:49 INFO - Running setup.py (path:/tmp/pip-XPltrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:19:49 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)) 15:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:19:49 INFO - Running setup.py (path:/tmp/pip-_ax2MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:19:49 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)) 15:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:19:49 INFO - Running setup.py (path:/tmp/pip-G_PMUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:19:49 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)) 15:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:19:49 INFO - Running setup.py (path:/tmp/pip-S7uL9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:19:49 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)) 15:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:19:49 INFO - Running setup.py (path:/tmp/pip-LfmHS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:19:49 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)) 15:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:19:49 INFO - Running setup.py (path:/tmp/pip-vhhqK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:19:49 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)) 15:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:19:49 INFO - Running setup.py (path:/tmp/pip-ct_t9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:19:49 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)) 15:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:19:49 INFO - Running setup.py (path:/tmp/pip-dRQOo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:19:49 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)) 15:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:19:49 INFO - Running setup.py (path:/tmp/pip-D1maSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:19:49 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)) 15:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:19:49 INFO - Running setup.py (path:/tmp/pip-oTsdL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:19:49 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)) 15:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:19:49 INFO - Running setup.py (path:/tmp/pip-VeTmmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:19:49 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)) 15:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:19:49 INFO - Running setup.py (path:/tmp/pip-gWH1_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:19:49 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)) 15:19:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:49 INFO - Running setup.py (path:/tmp/pip-e9ezhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:19:50 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)) 15:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:19:50 INFO - Running setup.py (path:/tmp/pip-hlZuYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:19:50 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)) 15:19:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:19:50 INFO - Running setup.py (path:/tmp/pip-E1Ap0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:19:50 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)) 15:19:50 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)) 15:19:50 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)) 15:19:50 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)) 15:19:50 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)) 15:19:50 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)) 15:19:50 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)) 15:19:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:19:50 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 15:19:50 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 15:19:50 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 15:19:50 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 15:19:51 INFO - Downloading blessings-1.6.tar.gz 15:19:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:19:51 INFO - Installing collected packages: blessings 15:19:51 INFO - Running setup.py install for blessings 15:19:51 INFO - Successfully installed blessings 15:19:51 INFO - Cleaning up... 15:19:51 INFO - Return code: 0 15:19:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:19:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:51 INFO - Reading from file tmpfile_stdout 15:19:51 INFO - Current package versions: 15:19:51 INFO - argparse == 1.2.1 15:19:51 INFO - blessings == 1.6 15:19:51 INFO - blobuploader == 1.2.4 15:19:51 INFO - docopt == 0.6.1 15:19:51 INFO - functools32 == 3.2.3-2 15:19:51 INFO - jsonschema == 2.5.1 15:19:51 INFO - manifestparser == 1.1 15:19:51 INFO - mozInstall == 1.13 15:19:51 INFO - mozcrash == 1.0 15:19:51 INFO - mozdebug == 0.1 15:19:51 INFO - mozdevice == 0.51 15:19:51 INFO - mozfile == 1.2 15:19:51 INFO - mozhttpd == 0.7 15:19:51 INFO - mozinfo == 0.10 15:19:51 INFO - mozleak == 0.1 15:19:51 INFO - mozlog == 3.5 15:19:51 INFO - moznetwork == 0.27 15:19:51 INFO - mozprocess == 0.25 15:19:51 INFO - mozprofile == 0.28 15:19:51 INFO - mozrunner == 6.13 15:19:51 INFO - mozscreenshot == 0.1 15:19:51 INFO - mozsystemmonitor == 0.3 15:19:51 INFO - moztest == 0.8 15:19:51 INFO - mozversion == 1.4 15:19:51 INFO - psutil == 3.1.1 15:19:51 INFO - requests == 1.2.3 15:19:51 INFO - wsgiref == 0.1.2 15:19:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:19: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')]} 15:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19: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')]} 15:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:51 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 0x9d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd46eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd44050>, '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 0xd44f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd453e0>, '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': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', '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 15:19:51 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 15:19:51 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 15:19:51 INFO - Using env: {'DISPLAY': ':0', 15:19:51 INFO - 'HOME': '/home/cltbld', 15:19:51 INFO - 'LANG': 'en_US.UTF-8', 15:19:51 INFO - 'LANGUAGE': 'en_US:en', 15:19:51 INFO - 'LOGNAME': 'cltbld', 15:19:51 INFO - 'MAIL': '/var/mail/cltbld', 15:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:51 INFO - 'MOZ_NO_REMOTE': '1', 15:19:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:51 INFO - 'NO_EM_RESTART': '1', 15:19:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:51 INFO - 'PWD': '/builds/slave/test', 15:19:51 INFO - 'SHELL': '/bin/bash', 15:19:51 INFO - 'SHLVL': '1', 15:19:51 INFO - 'TERM': 'linux', 15:19:51 INFO - 'TMOUT': '86400', 15:19:51 INFO - 'USER': 'cltbld', 15:19:51 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', 15:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:51 INFO - '_': '/tools/buildbot/bin/python'} 15:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:51 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)) 15:19:51 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)) 15:19:51 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)) 15:19:51 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)) 15:19:51 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)) 15:19:51 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)) 15:19:51 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)) 15:19:51 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)) 15:19:51 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)) 15:19:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:19: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 15:19: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 15:19: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 15:19: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 15:19:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:19:53 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)) 15:19:53 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)) 15:19:53 INFO - Installing collected packages: simplejson 15:19:53 INFO - Running setup.py install for simplejson 15:19:53 INFO - building 'simplejson._speedups' extension 15:19:53 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 15:19:54 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 15:19:54 INFO - Successfully installed simplejson 15:19:54 INFO - Cleaning up... 15:19:54 INFO - Return code: 0 15:19:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:19:54 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')]} 15:19:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:19:54 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')]} 15:19:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:19:54 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 0x9d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd46eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd44050>, '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 0xd44f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd453e0>, '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': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', '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 15:19:54 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 15:19:54 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 15:19:54 INFO - Using env: {'DISPLAY': ':0', 15:19:54 INFO - 'HOME': '/home/cltbld', 15:19:54 INFO - 'LANG': 'en_US.UTF-8', 15:19:54 INFO - 'LANGUAGE': 'en_US:en', 15:19:54 INFO - 'LOGNAME': 'cltbld', 15:19:54 INFO - 'MAIL': '/var/mail/cltbld', 15:19:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:19:54 INFO - 'MOZ_NO_REMOTE': '1', 15:19:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:19:54 INFO - 'NO_EM_RESTART': '1', 15:19:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:19:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:19:54 INFO - 'PWD': '/builds/slave/test', 15:19:54 INFO - 'SHELL': '/bin/bash', 15:19:54 INFO - 'SHLVL': '1', 15:19:54 INFO - 'TERM': 'linux', 15:19:54 INFO - 'TMOUT': '86400', 15:19:54 INFO - 'USER': 'cltbld', 15:19:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', 15:19:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:19:54 INFO - '_': '/tools/buildbot/bin/python'} 15:19:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:19:54 INFO - Cleaning up... 15:19:54 INFO - Return code: 0 15:19:54 INFO - Running post-action listener: _resource_record_post_action 15:19:54 INFO - Running post-action listener: _start_resource_monitoring 15:19:54 INFO - Starting resource monitoring. 15:19:54 INFO - [mozharness: 2017-08-09 22:19:54.450410Z] Finished create-virtualenv step (success) 15:19:54 INFO - [mozharness: 2017-08-09 22:19:54.450924Z] Running install step. 15:19:54 INFO - Running pre-action listener: _resource_record_pre_action 15:19:54 INFO - Running main action method: install 15:19:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:19:54 INFO - Reading from file tmpfile_stdout 15:19:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:19:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:19:54 INFO - Reading from file tmpfile_stdout 15:19:54 INFO - Output received: 15:19:54 INFO - Usage: mozinstall [options] installer 15:19:54 INFO - Options: 15:19:54 INFO - -h, --help show this help message and exit 15:19:54 INFO - -d DEST, --destination=DEST 15:19:54 INFO - Directory to install application into. [default: 15:19:54 INFO - "/builds/slave/test"] 15:19:54 INFO - --app=APP Application being installed. [default: firefox] 15:19:54 INFO - mkdir: /builds/slave/test/build/application 15:19:54 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'] 15:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:20:09 INFO - Reading from file tmpfile_stdout 15:20:09 INFO - Output received: 15:20:09 INFO - /builds/slave/test/build/application/firefox/firefox 15:20:09 INFO - Running post-action listener: _resource_record_post_action 15:20:09 INFO - [mozharness: 2017-08-09 22:20:09.473537Z] Finished install step (success) 15:20:09 INFO - [mozharness: 2017-08-09 22:20:09.473653Z] Running setup-mitmproxy step. 15:20:09 INFO - Running pre-action listener: _resource_record_pre_action 15:20:09 INFO - Running main action method: setup_mitmproxy 15:20:09 INFO - Skipping: mitmproxy is not required 15:20:09 INFO - Running post-action listener: _resource_record_post_action 15:20:09 INFO - [mozharness: 2017-08-09 22:20:09.474125Z] Finished setup-mitmproxy step (success) 15:20:09 INFO - [mozharness: 2017-08-09 22:20:09.474217Z] Running run-tests step. 15:20:09 INFO - Running pre-action listener: _resource_record_pre_action 15:20:09 INFO - Running pre-action listener: _set_gcov_prefix 15:20:09 INFO - Running main action method: run_tests 15:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:20:09 INFO - Python 2.7.3 15:20:09 INFO - Return code: 0 15:20:09 INFO - grabbing minidump binary from tooltool 15:20:09 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')]} 15:20:09 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 0xd44050>, '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 0xd44f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd453e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:20:09 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 15:20:09 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 15:20:09 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 15:20:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:20:09 INFO - Return code: 0 15:20:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:20:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:20:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:20:09 INFO - ENV: RUST_BACKTRACE is now 1 15:20:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:20:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:20:09 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/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 15:20:09 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/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 15:20:09 INFO - Using env: {'DISPLAY': ':0', 15:20:09 INFO - 'HOME': '/home/cltbld', 15:20:09 INFO - 'LANG': 'en_US.UTF-8', 15:20:09 INFO - 'LANGUAGE': 'en_US:en', 15:20:09 INFO - 'LOGNAME': 'cltbld', 15:20:09 INFO - 'MAIL': '/var/mail/cltbld', 15:20:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:20:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:09 INFO - 'MOZ_NO_REMOTE': '1', 15:20:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:09 INFO - 'NO_EM_RESTART': '1', 15:20:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:09 INFO - 'PWD': '/builds/slave/test', 15:20:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:20:09 INFO - 'RUST_BACKTRACE': '1', 15:20:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:20:09 INFO - 'SHELL': '/bin/bash', 15:20:09 INFO - 'SHLVL': '1', 15:20:09 INFO - 'TERM': 'linux', 15:20:09 INFO - 'TMOUT': '86400', 15:20:09 INFO - 'USER': 'cltbld', 15:20:09 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334', 15:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:09 INFO - '_': '/tools/buildbot/bin/python'} 15:20:09 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/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 15:20:09 INFO - mozversion application_buildid: 20170809205914 15:20:09 INFO - mozversion application_changeset: 7f9c0489c233d437b23f2810c80b383f59106de5 15:20:09 INFO - mozversion application_display_name: Firefox 15:20:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:20:09 INFO - mozversion application_name: Firefox 15:20:09 INFO - mozversion application_remotingname: firefox 15:20:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:20:09 INFO - mozversion application_vendor: Mozilla 15:20:09 INFO - mozversion application_version: 56.0 15:20:09 INFO - mozversion platform_buildid: 20170809205914 15:20:09 INFO - mozversion platform_changeset: 7f9c0489c233d437b23f2810c80b383f59106de5 15:20:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:20:09 INFO - mozversion platform_version: 56.0 15:20:09 INFO - using testdate: 1502317209 15:20:09 INFO - actual date: 1502317209 15:20:09 INFO - starting webserver on 'localhost:40250' 15:20:09 INFO - SUITE-START | Running 2 tests 15:20:09 INFO - TEST-START | dromaeo_css 15:20:09 INFO - Initialising browser for dromaeo_css test... 15:20:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40250/getInfo.html -profile /tmp/tmpsFOV50/profile 15:20:09 INFO - TEST-INFO | started process 11750 (/builds/slave/test/build/application/firefox/firefox http://localhost:40250/getInfo.html) 15:20:15 INFO - TEST-INFO | 11750: exit 0 15:20:15 INFO - Browser initialized. 15:20:15 INFO - Running cycle 1/1 for dromaeo_css test... 15:20:15 INFO - TEST-INFO | started process 11915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsFOV50/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:20:15 INFO - PID 11915 | 1502317215956 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 15:20:16 INFO - PID 11915 | 15:20:16 INFO - PID 11915 | (/builds/slave/test/build/application/firefox/firefox:11964): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:20:16 INFO - PID 11915 | 15:20:26 INFO - PID 11915 | RSS: Main: 154288128 15:20:26 INFO - PID 11915 | 15:23:24 INFO - PID 11915 | Cycle 1(1): loaded http://localhost:40250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40250/tests/dromaeo/cssquery-ext.html) 15:23:25 INFO - PID 11915 | RSS: Main: 160862208 15:23:25 INFO - PID 11915 | 15:26:27 INFO - PID 11915 | Cycle 1(1): loaded http://localhost:40250/tests/dromaeo/cssquery-ext.html (next: http://localhost:40250/tests/dromaeo/cssquery-jquery.html) 15:26:27 INFO - PID 11915 | RSS: Main: 157384704 15:26:27 INFO - PID 11915 | 15:29:29 INFO - PID 11915 | Cycle 1(1): loaded http://localhost:40250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40250/tests/dromaeo/cssquery-mootools.html) 15:29:29 INFO - PID 11915 | RSS: Main: 158912512 15:29:29 INFO - PID 11915 | 15:32:31 INFO - PID 11915 | Cycle 1(1): loaded http://localhost:40250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40250/tests/dromaeo/cssquery-prototype.html) 15:32:32 INFO - PID 11915 | RSS: Main: 158908416 15:32:32 INFO - PID 11915 | 15:35:35 INFO - PID 11915 | Cycle 1(1): loaded http://localhost:40250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40250/tests/dromaeo/cssquery-yui.html) 15:35:35 INFO - PID 11915 | RSS: Main: 161107968 15:35:35 INFO - PID 11915 | 15:38:37 INFO - PID 11915 | Cycle 1(1): loaded http://localhost:40250/tests/dromaeo/cssquery-yui.html (next: http://localhost:40250/tests/dromaeo/cssquery-dojo.html) 15:38:37 INFO - PID 11915 | RSS: Main: 164069376 15:38:37 INFO - PID 11915 | 15:38:37 INFO - PID 11915 | __start_tp_report 15:38:37 INFO - PID 11915 | _x_x_mozilla_page_load 15:38:37 INFO - PID 11915 | _x_x_mozilla_page_load_details 15:38:37 INFO - PID 11915 | |i|pagename|runs| 15:38:37 INFO - PID 11915 | |0;dojo.html;3572.8928132156043;3599.15419876329;3601.081724160339;3609.981950090249;3622.5652921649407;6413.903791443132;6440.806775796727;6476.676166191689;6512.446442052419;6513.283538810733;6436.1311222985;6469.482441404676;6535.869282614345;6540.803775886731;6546.803595892131;5506.201600767887;5516.475934786209;5547.33431988162;5653.802116925908;5679.034564124109;5554.583406244527;5654.660720356771;5656.604037717341;5680.772769089232;5695.34503532095;5518.33779946405;5564.1931919871395;5574.888502229973;5625.128105143709;5663.093904975205;5495.917561236584;5576.832695019115;5591.8881622367735;5636.605437619368;5649.180868774005;5518.19986102017;5548.0845660465975;5577.776888924438;5591.664500130005;5610.214569960209;6224.066390041485;6313.179286692746;6316.273628532732;6381.425671689571;6415.967920160369;6868.828279293008;6934.895976560356;6958.512904096715;6967.477439192081;6989.4408447324095;6915.550489218235;6960.65196740161;7002.054722612433;7059;7088.751893683696;6424;6428.77499287532;6486.189226346707;6527.771527996545;6555.410013098844;7032.789016329519;7119.4660400470175;7130.03744494497;7130.607816570035;7149.96425017882;6751.696173672197;6758.493113016445;6767.830804229934;6809.625470599165;6832.931670683329;6848.486363522756;6992.580445173306;6996.475264355194;7004.509684322048;7004.614746188907;6787.219469760942;6847.897281540781;6857.55425897315;6860.485463590251;6860.5197636165985;6848.520603557703;6857.314268573103;6867.690953907087;6898.310168983162;6908.032875397448;4974.527419895104;5067.949320506821;5070.315507406527;5087;5096.159133742965;4520.841770538015;4556.157110934421;4563.361129441881;4571.588557029883;4577;6524.902126468107;6593.406593406617;6611.107500487469;6680.665966701646;6682.3317668232785;6997.440204783605;6999.580025198505;7000.404965577983;7040.084788977502;7040.295970402919;6626.635535045522;6642.501812364092;6670.099536562502;6688.531802773759;6693.832654183684;5794.246747922827;5851.941480585139;5909.025010873243;5919.4080591940465;5919.6744179070565;6962.686679099453;7051.682674279669;7112.324329188822;7182.281771822881;7224.385927196247;6972.651367431709;7054;7055.435565154878;7062.4703147263135;7069.22238553769;7116.5730056194725;7149.320814522612;7165.426765858614;7197.46019048563;7235.710571577289;6677.465802735673;6738.764143254963;6840.281770414035;6886.48351373659;6957.860842783217;7014.649267536501;7041;7042;7048.330408611174;7063.540869843444;6713.865722685617;6782.28785977485;6854.554453960476;6876.862462750617;6878.8624227516175;6653.401193892573;6744.865102698017;6752.155980502437;6765.221999469927;6774;6734.057231987624;6740.662966851736;6759.459243260626;6762.52662313653;6766.594004359754;6758.898616520658;6802.965985170043;6805;6875.140607424072;6887.070245516991;6534.183227096613;6620.470362371095;6632.436242919213;6633.70148343316;6719.328067193437 15:38:37 INFO - PID 11915 | |1;ext.html;883.8879296813686;918.8208299381623;928.4243768863304;981.0532835813439;982.4301904895161;42162;42885.57114428855;43104;43144;43262.35106473398;39906;40160.39759403611;40167;40175;40232;7188.065551478314;7282;7302.05073340465;7304.379127774119;7308.196098429195;7115;7168.569885806843;7185.173705023937;7185.748498802543;7186.065811444531;7946.523208607502;8118.959405202966;8152.062512811014;8159.918400816005;8162.224588664097;7995.600219988977;8036.517808931483;8090.919090809105;8100.189981001941;8107;7814.53112813233;7961.522308661441;7969.123396426388;7969.800754981114;8012.439129260954;41062.178756424706;41178;41386.79306603448;41473.58526414757;41500.1699966002;3700.3709369407266;3756.4553139794575;3765.1151979284846;3770.9434358484646;3774.2074164425503;32343.83828080868;32357.352852942808;32521.186970325696;32548.511772323196;32715.83642081798;5202.323697919284;5255.842324730264;5258.290130832365;5263.394709608406;5296.629235953485;211142;213846;217339;218383;230459.8477007621;51679.22481162786;51700;51880.22179667308;51965.48034519682;52083;55126.44873551293;55567.16649250264;55589.722051389486;55654.72172639111;55816.441835581936;17953.102344882704;18157.7276340855;18206.726899096524;18208.45374638763;18283.817161828476;15022.549323520312;15077.396904123712;15130.54608361751;15189.544313670607;15235.162066086472;15017;15208.16355100458;15409.152496612794;15521.301541430663;15653;5966.522678185735;6010.639361638316;6177.2587289524645;6183.876322473526;6240.656763878031;1123.1856903744883;1124.2579897267929;1127.4306475229957;1144.4621028116771;1149.0405511398076;25738.35654108662;25796.35509112287;25832.483350333263;25917.481650366888;26085.08702195414;1240.3674126195524;1264.6585421936027;1268.7399083187925;1277.0613599004723;1278.571678487717;13707.314634268247;17935.820641793674;18210.726839097424;18372.81627183738;18492.630147396976;301287;301589;302144;304504;305725;62043.37956620466;62500.687496563136;62746.37253627405;62801;63486.36513634897;1567.7021365940664;1573.7403328450678;1589.2212815720213;1597.5367143528247;1600.6798640271993;30668.539971900886;30864.228394289425;31074;31307.53038704467;32212.033638990866;55921.16118258148;56331.436685632616;56452;56780.148297776395;56884.43115568791;184111;184964.1503584947;184990;185291;186130;37151.6284837159;38170.809145954096;39106.80446597749;39209.60790392174;39460.60539394569;47192.29211561761;48354.75822620864;48422.27366589433;48605.513944861515;48753.75623121862;33755;34528.654713452546;34939.65060349364;35045;35262.82368588243;34731.13172170716;34752.65247347494;34807;34913.650863492054;35044.29911401809;41463.7926810364;41723.7913810429;41905;42257;42442;32960.340793184485;33400.498992514644;33505.49741753827;33637;33692.157696057795;26185.607215891396;26533;27210.45579088447;27234.455310894067;27422.45155096927 15:38:37 INFO - PID 11915 | |2;jquery.html;565.1322379535636;578.7916350113961;579.8550362409397;580.9128630705396;619.0837560410592;23437.414064648372;24294.75705242947;24352.147674831383;24375.14686985958;24421;25368.873155634195;27916;28235.15294541162;28475.85762071192;28511.57232641512;6506.804795856132;6641.203055633331;6642.036904648823;6643.534952553323;6648;6320;6500.9674951625175;6589.736410543596;6637.037629543714;6647.268800431949;6561.8031459056065;6575.736970521173;6580.749657565071;6585.769498067569;6596.967015164942;6587.703553340088;6597.340265973412;6601.306862779387;6609.801705948805;6643.368879956444;6099.756009759604;6124.479419249369;6151.446369826737;6157;6166.1983942087245;31424.214394640087;31897;32077.1980700482;32148.678513214803;32474.512882306783;2267.807236384909;2284.383216531544;2289.97710022901;2298.402415371999;2306.8039216666602;20244;20874.37376878696;21066.368008959602;21082;21093.367198984055;2418.6734790803193;2424.866632335221;2474.4556197636493;2516.8238223324374;2536.2898388451263;151195.24402378028;152748.9999999989;153612;154039.2298038514;154387;15968.441104561285;16482.587935301475;16574.254158562893;17044.744328835077;17124.14379281031;25986.22041338763;25998.22005339843;26017.609735853977;26050.218493445227;26073.73926260713;11424.42877856104;11632.892731316128;11687.76624467523;11755.471003804849;11887.632922214056;9905.455199963926;11083.72290692739;11194.720131996764;11267.211295209421;11522.654320370402;8805.911940880509;10088.546015429323;10146.188304935735;10369.118624916966;10451.895481045092;2954.630671166104;2956.74867636249;2958.3343747657036;2959.7928145030073;2988.193187839271;1056.1234175634359;1091.7379828841022;1092.7104317355906;1096.1121491591837;1098.6868742408376;22390.664140037912;22549.774502255095;22638.547229055326;22688.773112268995;22948.082076716746;1167.0430247197387;1170.6019953215948;1175.3887978251262;1176.253079294654;1181.4270079011671;12257.93871030657;12431.93784031074;12496.937515312366;12529.498820047096;12641.2415255085;573917;580021;586002;596357;602918;132390.33804831107;132730.33634831765;134682.32658836644;134884;137647;1275.3559452476625;1310.3644732304824;1336.6992426704107;1336.9665758356118;1337.732453509302;19382.12780424856;19610.607787843877;20085.59828803445;20120.39638810838;20218.292359767336;62200.37799622127;62928.370716294085;63822.68088659527;64319.35680643134;64675.67662161659;77406.6129669348;77737.22262777526;78116.2188378109;78144.21855781597;78408.60795695985;13766.449342026608;14252.643683907985;15303;15800.209989500248;16285.837141628432;24169.879150604836;24478.265652030466;24542.877285613456;24610.753892461562;24614;19077.141528630968;19308;19548.902255488632;19621.215151393786;19628.4297256222;16853.747193791856;17090.2309396075;17220.913895430444;17326.30694772195;17749.645007100044;19486;19558;19683.507912302306;19859.304924328157;19902;15847.68304633924;15878.729701623612;16061.357545698042;16127.354905803637;16178.838211617733;19776.011199439683;19874.304399345954;19998.300059497848;20026.59946801085;20066.89632070192 15:38:37 INFO - PID 11915 | |3;mootools.html;1414.8186264469168;1475.4024620028886;1486.8959172857903;1488.1517535005044;1500.3098574655658;15653.373865045398;16002.279897404645;16388.67222655546;16401.097939613315;16403.261853216605;16950.3219871205;17185.82814171858;17241.051742154206;17247;17267.050312232823;2867.3261783480866;2924.488214562454;2925.956110658342;2927.912162635114;2928.2240206345336;2925.3710452252762;2966.3029188140767;2987.1785259053718;3017.6722242213464;3066.064850220682;3050.9626726912843;3057.2509735114927;3060.831654259015;3082.383523295339;3089.490234111369;2979.6573394059637;2980.2847316643956;3028.515437529996;3030.10611869499;3031.4998025325795;2849.8575071246564;2894.2619631993916;2898.347871728844;2900.622919020535;2905.4915389806697;15895.364185432569;16218.270177842025;16295.266712997944;16309.51071467858;16316.184190790531;8453.281471074966;8660;8738.694145704934;8762.518061506615;8781.780455488664;5359.330083739533;5610.410906854762;5726.9713651431475;5731.426857314277;5734.655920644733;1987.1951859496926;2014.8287395571394;2016.5059560407647;2065.493953981284;2072.2954195573425;28040;28345.71654283472;28401.85799071012;28408.289792755346;28428.573571396446;7292.3801476874;7328.9267107329315;7446;7588;7603.46775725705;19099.61800764005;19314.32399865998;19321.323753668556;19346;19355;8517.829643407098;8664;8669.869951950726;8681.6527338907;8695.217430431165;8021.639026243833;8024.2376974187355;8088.636011379502;8090.838183236302;8124.7562573122905;5794.855128621818;5973.223480947449;5983.700814959322;6044.335123136451;6091.604045737013;1616.8625666818452;1646.7694522766822;1669.5992961689108;1726.3871325679454;1801.261482792049;985.5417230987482;999.7400675824338;1001.3140998416109;1006.3861044762689;1021.8671572695501;9568.521573921415;9779.755506112262;9963.402195868272;9974.202063834875;10027.398356098658;1068.56188962525;1089.3028461784463;1092.8306112552566;1094.1574987259764;1097.078454098561;5792.88414231713;6213.937860621426;6260.780872669526;6279.968600157062;6401.775937842246;23275.301740947798;23871.880640596686;23944.88027559851;24021.159259425836;24057.879710601686;22226.333210003402;23474.64788028181;23638.763612363655;23853.403664908168;23888.761112388653;12172.81740773889;12218.389080545938;12284.078694097978;12370.81443778344;12429.875701243052;9618.682940449158;9891.406515609087;9974.202063834731;10053.74328208974;10393.532291047073;20255.4936126598;20373.694394583796;20498.975051247675;20987.580248394643;21232.681509777056;20893.686594701394;21061.157553698293;21305.573888521834;21384.144634214455;21626.567468650224;13349.466021359036;13687.931560342135;13700.520481783089;13700.725985480434;13741.24423156736;14853.257337133316;14916.925415372854;14918.403263869324;14978.775318370452;15027.549173524812;11795.764084718428;11909.106816988933;11909.642710718692;12062.75874482523;12242.510299588273;11270.267432616854;11637;11690.240134391237;11721.06231501495;12091.81862272049;10910.454477275945;11141.498632561716;11142.777144457228;11155.05182059534;11155.330680158891;8120.309773669304;8169.428140030141;8289.461185022954;8378.706745263886;8392.958035209786;8294;8419.115992820665;8427.705030323908;8453.450525715809;8472.66109355619 15:38:37 INFO - PID 11915 | |4;prototype.html;525.9474052594743;534.684536123687;556.5352930303196;562.7411390760251;570.386834153285;6302.369763023707;6315.684215789215;6337.778177763779;6358.80923572293;6374.418360563967;6256.874862502747;6257.873582755103;6257.937420625793;6283.371662833726;6300.164925783404;4832.202686556731;4938.629602779788;5005.299258103868;5019.874503137415;5051.974740126294;4932.679375840559;4937.321310754342;4941.851744447672;4943.752812359386;4955.504449555034;4825;4886.218205087187;4891.584215341701;4897.436794768611;4902.19113846215;4854.757262136879;4868.513148685139;4897.926531102018;4937.111319962405;4940.827071052496;4431.800568974404;4435.667324950641;4487.573680500347;4494.303382975644;4533.750643714594;6064;6096.817095487142;6100.481459075984;6112.724927378279;6135.754569817202;5877.177195192677;5896.941030589725;5903.586748927577;5927.970360148215;5934.406559344031;6730.596164230113;6744.527883048188;6750.1562304711915;6810.990757726483;6841.008053832216;5061.797528098871;5073.949260507385;5074.644774865761;5087.160618497944;5097.847064588068;6735.696893639798;6856.52004359695;6968.547044442095;7027.43780497559;7028.508004439691;5192.350956130484;5231.869203269873;5235.377033119745;5259.789608415621;5262.210668399771;5252.868678283074;5271.288376069181;5280.498352656491;5343.3587969443915;5343.7060961647485;5859.1797148399255;5873.618214816023;5896.3219229788265;5913.704314784243;5929.6145750526075;6739;6753.3921947025;6779.186497620317;6813.761518346834;6816.965915170393;1847.464235371754;1860.9720854187199;1866.2348437140706;1866.4400679796279;1869.7662792150982;1266.4554241676167;1283.140296001681;1309.8428188617427;1317.8286822713178;1318.3276528970293;6453.1610890583925;6493.902591461132;6508.739650414025;6524.9673751630935;6578.572392794453;6704.229013663491;6738.3491044694365;6863.313668633196;6889.517733758589;6996.265392133854;6418.935810641834;6425.325340839238;6425.678716064178;6451.645159516272;6468.611883287018;3658.579263384745;3672.8347224374966;3687.686546643565;3695.796731179757;3701.3522633539023;7052.637366482183;7086.716531338792;7090.503664743522;7092.687852747258;7101.467389945775;6979.511434199659;6997.755078572225;7047.330503602149;7060.6469676517;7149.964250178716;6906.654667266516;6923.896141557881;6978.616176110363;6991.999999999898;7071.611061391673;6806.557573757888;6838.658067096725;6860.622665753432;6919.654017299215;6930.232790638355;6654.866902662016;6686.53194276396;6773;6795.354441328066;6802.292750451115;6924.446044316342;7016.36852683261;7019.964900175466;7071.055459748404;7102.502824802421;5246.2392953020835;5278.762455689426;5293.9205911910585;5313.52178303939;5348.1442969124755;6542.738290468328;6673.1992160941;6894.689738961659;6950.513464057467;6984.965075174591;6719.3873470367735;6725.49558783103;6725.529212955242;6734.797956061326;6740.9325906740305;6521.445677117498;6649.202095748541;6692.096566963398;6695.296993815774;6715.3547380892;6493.415592596689;6557.114789503356;6622.503312251504;6628.602283862983;6640.90038649411;6649.301823308483;6659.367360100783;6661.367170118831;6691.297413771484;6728.428083612752;6479.643619600967;6510.9674451629335;6521.250056243593;6527;6558.508111891722 15:38:37 INFO - PID 11915 | |5;yui.html;956.3353469338808;961.6105477281699;992.3995982430629;1007.7027276953298;1014.2089170447053;19042.428727138173;19143.712844307345;19355.22579096836;19363.903180484114;21972.230971915986;21951;22460.775392246072;22547.887260563715;22631.66052509214;22640.320790376314;1013.3818370793829;1032.3444612670971;1032.7160030991463;1034.2501686277426;1036.984445233322;1079.4386918802218;1108.894655007773;1112.3048094940661;1117.5753213778753;1118.3960661242918;1181.5569161564413;1183.5384200161943;1183.8224266360028;1184.8992835608983;1185.4250688416112;1166.6966588686917;1168.9649310520697;1170.1750266062406;1170.7951108556053;1171.6309362550812;852.7313896122702;854.9957250213771;855.7389996051202;857.014433401587;858.5449711652834;20366.083526241353;20407.183712651477;20478.590428191354;20673.5865282695;20997.895010525004;20868.495780506437;20995;21549.67675484869;21611.243606473698;21859.12563497458;15919.522414327588;15964.361425542964;16058;17101.657966840718;17641.470755877344;3756;3777.9433308500393;3781.4138808484727;3784.3377408953597;3788.052986753312;144375.27812360975;144992;145803;146307;146468;16249.59376015609;16537;16740.079295638858;16756.83243167577;16782.496525104267;30561.541576876363;31274.214270360055;32035.35929281448;32236.03291901247;32236.516452253236;9372.5313734313;9537.189338906272;9588.856167157359;9596.90403095974;9626.326157169071;4493.370928070073;4582.221022426195;4604.700694454849;4616.60758835496;4628.722276663344;5780.595358324961;5894.67579283135;5903.498202652822;5912.083627037816;5920.674362910081;1150.8676502202354;1161.517970042423;1182.6274723462082;1186.851643544557;1188.3879801902028;740.4039748002801;755.4371992865241;767.2672597669213;769.0886299734832;773.014406631538;12435.129540932048;13138.802917956238;13284.402201900937;13295.73408531824;13317.933410332886;738.1363804348924;753.6947536247828;757.75373003774;770.5030255485293;772.0195351903163;5596.748146333425;5667.489925906688;5669.262995810601;5752.482276595043;5834.154047663065;126518;130763.34618326847;130819;131217;137099.31450342684;113246;114281;114596;114637;115861.42069289599;101562.49218754006;103464;104152.47923760333;107198;108269.45865270623;13649;13971.790423143457;13996.44014239419;14290;14329.928350358181;45968;46985.29522057103;47806;48548;49314;82977.58511207406;83121;83869.58065209635;84702;87897.80255493664;20321;20760.79239207649;20853.165873365502;20882.477938051063;21026.369208923756;22331.77668223297;22365.888170559043;22455.66316505221;23018.53962920766;23162.652560211274;20273.29043483471;20738.688919665914;20904.16383344649;21510.354689359345;21844.126234951058;18312;18773.530661733566;20022.499437513598;21172.364829055154;21383.893080534497;19543.902280488506;19648.410547683594;19675.508112297306;19707.70438443453;19863.60272794565;14352.56942291733;14671.413143474141;14894.478693245685;15083.622909427351;15224.46714364992;14489.275536223358;14697.85302146965;15013.099214047192;15056.623584410478;15096.094234345974 15:38:37 INFO - PID 11915 | __end_tp_report 15:38:37 INFO - PID 11915 | __start_cc_report 15:38:37 INFO - PID 11915 | _x_x_mozilla_cycle_collect,289 15:38:37 INFO - PID 11915 | __end_cc_report 15:38:37 INFO - PID 11915 | __startTimestamp1502318317553__endTimestamp 15:38:37 INFO - PID 11915 | 15:38:37 INFO - PID 11915 | ------- Summary: start ------- 15:38:37 INFO - PID 11915 | Number of tests: 6 15:38:37 INFO - PID 11915 | 15:38:37 INFO - PID 11915 | [#0] dojo.html Cycles:165 Average:6383.29 Median:6719.33 stddev:817.97 (12.2%) stddev-sans-first:790.21 15:38:37 INFO - PID 11915 | Values: 3572.9 3599.2 3601.1 3610.0 3622.6 6413.9 6440.8 6476.7 6512.4 6513.3 6436.1 6469.5 6535.9 6540.8 6546.8 5506.2 5516.5 5547.3 5653.8 5679.0 5554.6 5654.7 5656.6 5680.8 5695.3 5518.3 5564.2 5574.9 5625.1 5663.1 5495.9 5576.8 5591.9 5636.6 5649.2 5518.2 5548.1 5577.8 5591.7 5610.2 6224.1 6313.2 6316.3 6381.4 6416.0 6868.8 6934.9 6958.5 6967.5 6989.4 6915.6 6960.7 7002.1 7059.0 7088.8 6424.0 6428.8 6486.2 6527.8 6555.4 7032.8 7119.5 7130.0 7130.6 7150.0 6751.7 6758.5 6767.8 6809.6 6832.9 6848.5 6992.6 6996.5 7004.5 7004.6 6787.2 6847.9 6857.6 6860.5 6860.5 6848.5 6857.3 6867.7 6898.3 6908.0 4974.5 5067.9 5070.3 5087.0 5096.2 4520.8 4556.2 4563.4 4571.6 4577.0 6524.9 6593.4 6611.1 6680.7 6682.3 6997.4 6999.6 7000.4 7040.1 7040.3 6626.6 6642.5 6670.1 6688.5 6693.8 5794.2 5851.9 5909.0 5919.4 5919.7 6962.7 7051.7 7112.3 7182.3 7224.4 6972.7 7054.0 7055.4 7062.5 7069.2 7116.6 7149.3 7165.4 7197.5 7235.7 6677.5 6738.8 6840.3 6886.5 6957.9 7014.6 7041.0 7042.0 7048.3 7063.5 6713.9 6782.3 6854.6 6876.9 6878.9 6653.4 6744.9 6752.2 6765.2 6774.0 6734.1 6740.7 6759.5 6762.5 6766.6 6758.9 6803.0 6805.0 6875.1 6887.1 6534.2 6620.5 6632.4 6633.7 6719.3 15:38:37 INFO - PID 11915 | 15:38:37 INFO - PID 11915 | [#1] ext.html Cycles:180 Average:42508.54 Median:20972.51 stddev:62715.30 (299.0%) stddev-sans-first:62813.36 15:38:37 INFO - PID 11915 | Values: 883.9 918.8 928.4 981.1 982.4 42162.0 42885.6 43104.0 43144.0 43262.4 39906.0 40160.4 40167.0 40175.0 40232.0 7188.1 7282.0 7302.1 7304.4 7308.2 7115.0 7168.6 7185.2 7185.7 7186.1 7946.5 8119.0 8152.1 8159.9 8162.2 7995.6 8036.5 8090.9 8100.2 8107.0 7814.5 7961.5 7969.1 7969.8 8012.4 41062.2 41178.0 41386.8 41473.6 41500.2 3700.4 3756.5 3765.1 3770.9 3774.2 32343.8 32357.4 32521.2 32548.5 32715.8 5202.3 5255.8 5258.3 5263.4 5296.6 211142.0 213846.0 217339.0 218383.0 230459.8 51679.2 51700.0 51880.2 51965.5 52083.0 55126.4 55567.2 55589.7 55654.7 55816.4 17953.1 18157.7 18206.7 18208.5 18283.8 15022.5 15077.4 15130.5 15189.5 15235.2 15017.0 15208.2 15409.2 15521.3 15653.0 5966.5 6010.6 6177.3 6183.9 6240.7 1123.2 1124.3 1127.4 1144.5 1149.0 25738.4 25796.4 25832.5 25917.5 26085.1 1240.4 1264.7 1268.7 1277.1 1278.6 13707.3 17935.8 18210.7 18372.8 18492.6 301287.0 301589.0 302144.0 304504.0 305725.0 62043.4 62500.7 62746.4 62801.0 63486.4 1567.7 1573.7 1589.2 1597.5 1600.7 30668.5 30864.2 31074.0 31307.5 32212.0 55921.2 56331.4 56452.0 56780.1 56884.4 184111.0 184964.2 184990.0 185291.0 186130.0 37151.6 38170.8 39106.8 39209.6 39460.6 47192.3 48354.8 48422.3 48605.5 48753.8 33755.0 34528.7 34939.7 35045.0 35262.8 34731.1 34752.7 34807.0 34913.7 35044.3 41463.8 41723.8 41905.0 42257.0 42442.0 32960.3 33400.5 33505.5 33637.0 33692.2 26185.6 26533.0 27210.5 27234.5 27422.5 15:38:37 INFO - PID 11915 | 15:38:37 INFO - PID 11915 | [#2] jquery.html Cycles:180 Average:39678.04 Median:12453.18 stddev:98684.57 (792.4%) stddev-sans-first:98917.71 15:38:37 INFO - PID 11915 | Values: 565.1 578.8 579.9 580.9 619.1 23437.4 24294.8 24352.1 24375.1 24421.0 25368.9 27916.0 28235.2 28475.9 28511.6 6506.8 6641.2 6642.0 6643.5 6648.0 6320.0 6501.0 6589.7 6637.0 6647.3 6561.8 6575.7 6580.7 6585.8 6597.0 6587.7 6597.3 6601.3 6609.8 6643.4 6099.8 6124.5 6151.4 6157.0 6166.2 31424.2 31897.0 32077.2 32148.7 32474.5 2267.8 2284.4 2290.0 2298.4 2306.8 20244.0 20874.4 21066.4 21082.0 21093.4 2418.7 2424.9 2474.5 2516.8 2536.3 151195.2 152749.0 153612.0 154039.2 154387.0 15968.4 16482.6 16574.3 17044.7 17124.1 25986.2 25998.2 26017.6 26050.2 26073.7 11424.4 11632.9 11687.8 11755.5 11887.6 9905.5 11083.7 11194.7 11267.2 11522.7 8805.9 10088.5 10146.2 10369.1 10451.9 2954.6 2956.7 2958.3 2959.8 2988.2 1056.1 1091.7 1092.7 1096.1 1098.7 22390.7 22549.8 22638.5 22688.8 22948.1 1167.0 1170.6 1175.4 1176.3 1181.4 12257.9 12431.9 12496.9 12529.5 12641.2 573917.0 580021.0 586002.0 596357.0 602918.0 132390.3 132730.3 134682.3 134884.0 137647.0 1275.4 1310.4 1336.7 1337.0 1337.7 19382.1 19610.6 20085.6 20120.4 20218.3 62200.4 62928.4 63822.7 64319.4 64675.7 77406.6 77737.2 78116.2 78144.2 78408.6 13766.4 14252.6 15303.0 15800.2 16285.8 24169.9 24478.3 24542.9 24610.8 24614.0 19077.1 19308.0 19548.9 19621.2 19628.4 16853.7 17090.2 17220.9 17326.3 17749.6 19486.0 19558.0 19683.5 19859.3 19902.0 15847.7 15878.7 16061.4 16127.4 16178.8 19776.0 19874.3 19998.3 20026.6 20066.9 15:38:37 INFO - PID 11915 | 15:38:37 INFO - PID 11915 | [#3] mootools.html Cycles:180 Average:10314.48 Median:23862.64 stddev:7269.75 (30.5%) stddev-sans-first:7259.39 15:38:37 INFO - PID 11915 | Values: 1414.8 1475.4 1486.9 1488.2 1500.3 15653.4 16002.3 16388.7 16401.1 16403.3 16950.3 17185.8 17241.1 17247.0 17267.1 2867.3 2924.5 2926.0 2927.9 2928.2 2925.4 2966.3 2987.2 3017.7 3066.1 3051.0 3057.3 3060.8 3082.4 3089.5 2979.7 2980.3 3028.5 3030.1 3031.5 2849.9 2894.3 2898.3 2900.6 2905.5 15895.4 16218.3 16295.3 16309.5 16316.2 8453.3 8660.0 8738.7 8762.5 8781.8 5359.3 5610.4 5727.0 5731.4 5734.7 1987.2 2014.8 2016.5 2065.5 2072.3 28040.0 28345.7 28401.9 28408.3 28428.6 7292.4 7328.9 7446.0 7588.0 7603.5 19099.6 19314.3 19321.3 19346.0 19355.0 8517.8 8664.0 8669.9 8681.7 8695.2 8021.6 8024.2 8088.6 8090.8 8124.8 5794.9 5973.2 5983.7 6044.3 6091.6 1616.9 1646.8 1669.6 1726.4 1801.3 985.5 999.7 1001.3 1006.4 1021.9 9568.5 9779.8 9963.4 9974.2 10027.4 1068.6 1089.3 1092.8 1094.2 1097.1 5792.9 6213.9 6260.8 6280.0 6401.8 23275.3 23871.9 23944.9 24021.2 24057.9 22226.3 23474.6 23638.8 23853.4 23888.8 12172.8 12218.4 12284.1 12370.8 12429.9 9618.7 9891.4 9974.2 10053.7 10393.5 20255.5 20373.7 20499.0 20987.6 21232.7 20893.7 21061.2 21305.6 21384.1 21626.6 13349.5 13687.9 13700.5 13700.7 13741.2 14853.3 14916.9 14918.4 14978.8 15027.5 11795.8 11909.1 11909.6 12062.8 12242.5 11270.3 11637.0 11690.2 11721.1 12091.8 10910.5 11141.5 11142.8 11155.1 11155.3 8120.3 8169.4 8289.5 8378.7 8393.0 8294.0 8419.1 8427.7 8453.5 8472.7 15:38:37 INFO - PID 11915 | 15:38:37 INFO - PID 11915 | [#4] prototype.html Cycles:180 Average:5693.89 Median:6422.13 stddev:1604.09 (25.0%) stddev-sans-first:1560.99 15:38:37 INFO - PID 11915 | Values: 525.9 534.7 556.5 562.7 570.4 6302.4 6315.7 6337.8 6358.8 6374.4 6256.9 6257.9 6257.9 6283.4 6300.2 4832.2 4938.6 5005.3 5019.9 5052.0 4932.7 4937.3 4941.9 4943.8 4955.5 4825.0 4886.2 4891.6 4897.4 4902.2 4854.8 4868.5 4897.9 4937.1 4940.8 4431.8 4435.7 4487.6 4494.3 4533.8 6064.0 6096.8 6100.5 6112.7 6135.8 5877.2 5896.9 5903.6 5928.0 5934.4 6730.6 6744.5 6750.2 6811.0 6841.0 5061.8 5073.9 5074.6 5087.2 5097.8 6735.7 6856.5 6968.5 7027.4 7028.5 5192.4 5231.9 5235.4 5259.8 5262.2 5252.9 5271.3 5280.5 5343.4 5343.7 5859.2 5873.6 5896.3 5913.7 5929.6 6739.0 6753.4 6779.2 6813.8 6817.0 1847.5 1861.0 1866.2 1866.4 1869.8 1266.5 1283.1 1309.8 1317.8 1318.3 6453.2 6493.9 6508.7 6525.0 6578.6 6704.2 6738.3 6863.3 6889.5 6996.3 6418.9 6425.3 6425.7 6451.6 6468.6 3658.6 3672.8 3687.7 3695.8 3701.4 7052.6 7086.7 7090.5 7092.7 7101.5 6979.5 6997.8 7047.3 7060.6 7150.0 6906.7 6923.9 6978.6 6992.0 7071.6 6806.6 6838.7 6860.6 6919.7 6930.2 6654.9 6686.5 6773.0 6795.4 6802.3 6924.4 7016.4 7020.0 7071.1 7102.5 5246.2 5278.8 5293.9 5313.5 5348.1 6542.7 6673.2 6894.7 6950.5 6985.0 6719.4 6725.5 6725.5 6734.8 6740.9 6521.4 6649.2 6692.1 6695.3 6715.4 6493.4 6557.1 6622.5 6628.6 6640.9 6649.3 6659.4 6661.4 6691.3 6728.4 6479.6 6511.0 6521.3 6527.0 6558.5 15:38:37 INFO - PID 11915 | 15:38:37 INFO - PID 11915 | [#5] yui.html Cycles:180 Average:27140.39 Median:20343.54 stddev:38112.84 (187.3%) stddev-sans-first:38169.05 15:38:37 INFO - PID 11915 | Values: 956.3 961.6 992.4 1007.7 1014.2 19042.4 19143.7 19355.2 19363.9 21972.2 21951.0 22460.8 22547.9 22631.7 22640.3 1013.4 1032.3 1032.7 1034.3 1037.0 1079.4 1108.9 1112.3 1117.6 1118.4 1181.6 1183.5 1183.8 1184.9 1185.4 1166.7 1169.0 1170.2 1170.8 1171.6 852.7 855.0 855.7 857.0 858.5 20366.1 20407.2 20478.6 20673.6 20997.9 20868.5 20995.0 21549.7 21611.2 21859.1 15919.5 15964.4 16058.0 17101.7 17641.5 3756.0 3777.9 3781.4 3784.3 3788.1 144375.3 144992.0 145803.0 146307.0 146468.0 16249.6 16537.0 16740.1 16756.8 16782.5 30561.5 31274.2 32035.4 32236.0 32236.5 9372.5 9537.2 9588.9 9596.9 9626.3 4493.4 4582.2 4604.7 4616.6 4628.7 5780.6 5894.7 5903.5 5912.1 5920.7 1150.9 1161.5 1182.6 1186.9 1188.4 740.4 755.4 767.3 769.1 773.0 12435.1 13138.8 13284.4 13295.7 13317.9 738.1 753.7 757.8 770.5 772.0 5596.7 5667.5 5669.3 5752.5 5834.2 126518.0 130763.3 130819.0 131217.0 137099.3 113246.0 114281.0 114596.0 114637.0 115861.4 101562.5 103464.0 104152.5 107198.0 108269.5 13649.0 13971.8 13996.4 14290.0 14329.9 45968.0 46985.3 47806.0 48548.0 49314.0 82977.6 83121.0 83869.6 84702.0 87897.8 20321.0 20760.8 20853.2 20882.5 21026.4 22331.8 22365.9 22455.7 23018.5 23162.7 20273.3 20738.7 20904.2 21510.4 21844.1 18312.0 18773.5 20022.5 21172.4 21383.9 19543.9 19648.4 19675.5 19707.7 19863.6 14352.6 14671.4 14894.5 15083.6 15224.5 14489.3 14697.9 15013.1 15056.6 15096.1 15:38:37 INFO - PID 11915 | -------- Summary: end -------- 15:38:37 INFO - PID 11915 | 15:38:38 INFO - TEST-INFO | 11915: exit 0 15:38:38 INFO - TEST-OK | dromaeo_css | took 1108351ms 15:38:38 INFO - TEST-START | kraken 15:38:38 INFO - Initialising browser for kraken test... 15:38:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40250/getInfo.html -profile /tmp/tmpwiK4JF/profile 15:38:38 INFO - TEST-INFO | started process 12275 (/builds/slave/test/build/application/firefox/firefox http://localhost:40250/getInfo.html) 15:38:43 INFO - TEST-INFO | 12275: exit 0 15:38:43 INFO - Browser initialized. 15:38:43 INFO - Running cycle 1/1 for kraken test... 15:38:43 INFO - TEST-INFO | started process 12437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwiK4JF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:38:44 INFO - PID 12437 | 1502318324111 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 15:38:44 INFO - PID 12437 | 15:38:44 INFO - PID 12437 | (/builds/slave/test/build/application/firefox/firefox:12487): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:38:44 INFO - PID 12437 | 15:38:54 INFO - PID 12437 | RSS: Main: 154304512 15:38:54 INFO - PID 12437 | 15:38:57 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40250/tests/kraken/driver.html?testName=audio-beat-detection) 15:38:58 INFO - PID 12437 | RSS: Main: 161308672 15:38:58 INFO - PID 12437 | 15:39:00 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40250/tests/kraken/driver.html?testName=audio-dft) 15:39:01 INFO - PID 12437 | RSS: Main: 161726464 15:39:01 INFO - PID 12437 | 15:39:04 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40250/tests/kraken/driver.html?testName=audio-fft) 15:39:05 INFO - PID 12437 | RSS: Main: 161411072 15:39:05 INFO - PID 12437 | 15:39:07 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40250/tests/kraken/driver.html?testName=audio-oscillator) 15:39:07 INFO - PID 12437 | RSS: Main: 161832960 15:39:07 INFO - PID 12437 | 15:39:09 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:39:10 INFO - PID 12437 | RSS: Main: 161562624 15:39:10 INFO - PID 12437 | 15:39:13 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40250/tests/kraken/driver.html?testName=imaging-darkroom) 15:39:14 INFO - PID 12437 | RSS: Main: 161644544 15:39:14 INFO - PID 12437 | 15:39:17 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40250/tests/kraken/driver.html?testName=imaging-desaturate) 15:39:18 INFO - PID 12437 | RSS: Main: 164360192 15:39:18 INFO - PID 12437 | 15:39:20 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40250/tests/kraken/driver.html?testName=json-parse-financial) 15:39:21 INFO - PID 12437 | RSS: Main: 164298752 15:39:21 INFO - PID 12437 | 15:39:22 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:39:23 INFO - PID 12437 | RSS: Main: 164384768 15:39:23 INFO - PID 12437 | 15:39:25 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40250/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:39:25 INFO - PID 12437 | RSS: Main: 164802560 15:39:25 INFO - PID 12437 | 15:39:27 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:39:28 INFO - PID 12437 | RSS: Main: 161673216 15:39:28 INFO - PID 12437 | 15:39:31 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:39:31 INFO - PID 12437 | RSS: Main: 162082816 15:39:31 INFO - PID 12437 | 15:39:34 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:39:35 INFO - PID 12437 | RSS: Main: 162144256 15:39:35 INFO - PID 12437 | 15:39:36 INFO - PID 12437 | Cycle 1(1): loaded http://localhost:40250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40250/tests/kraken/driver.html?testName=ai-astar) 15:39:37 INFO - PID 12437 | RSS: Main: 163479552 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | __start_tp_report 15:39:37 INFO - PID 12437 | _x_x_mozilla_page_load 15:39:37 INFO - PID 12437 | _x_x_mozilla_page_load_details 15:39:37 INFO - PID 12437 | |i|pagename|runs| 15:39:37 INFO - PID 12437 | |0;ai-astar;97;106;101;106;105;108;112;98;110;110 15:39:37 INFO - PID 12437 | |1;audio-beat-detection;151;111;143;162;112;141;145;116;160;118 15:39:37 INFO - PID 12437 | |2;audio-dft;163;166;162;162;162;162;161;163;163;161 15:39:37 INFO - PID 12437 | |3;audio-fft;75;76;75;183;76;75;77;75;180;74 15:39:37 INFO - PID 12437 | |4;audio-oscillator;78;77;135;78;77;77;128;78;77;125 15:39:37 INFO - PID 12437 | |5;imaging-gaussian-blur;114;114;113;113;113;114;113;113;114;113 15:39:37 INFO - PID 12437 | |6;imaging-darkroom;150;147;147;154;148;148;147;147;149;150 15:39:37 INFO - PID 12437 | |7;imaging-desaturate;94;94;96;99;94;94;94;94;94;94 15:39:37 INFO - PID 12437 | |8;json-parse-financial;47;49;46;52;45;52;47;48;49;46 15:39:37 INFO - PID 12437 | |9;json-stringify-tinderbox;52;53;54;52;53;52;53;53;53;53 15:39:37 INFO - PID 12437 | |10;stanford-crypto-aes;80;73;73;73;80;73;73;72;74;73 15:39:37 INFO - PID 12437 | |11;stanford-crypto-ccm;120;122;116;129;120;119;124;127;113;129 15:39:37 INFO - PID 12437 | |12;stanford-crypto-pbkdf2;168;159;167;164;157;157;168;161;161;158 15:39:37 INFO - PID 12437 | |13;stanford-crypto-sha256-iterative;60;60;59;60;57;58;59;59;61;59 15:39:37 INFO - PID 12437 | __end_tp_report 15:39:37 INFO - PID 12437 | __start_cc_report 15:39:37 INFO - PID 12437 | _x_x_mozilla_cycle_collect,824 15:39:37 INFO - PID 12437 | __end_cc_report 15:39:37 INFO - PID 12437 | __startTimestamp1502318377044__endTimestamp 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | ------- Summary: start ------- 15:39:37 INFO - PID 12437 | Number of tests: 14 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#0] ai-astar Cycles:10 Average:105.30 Median:110.00 stddev:5.14 (4.7%) stddev-sans-first:4.49 15:39:37 INFO - PID 12437 | Values: 97.0 106.0 101.0 106.0 105.0 108.0 112.0 98.0 110.0 110.0 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:144.00 stddev:19.88 (13.8%) stddev-sans-first:20.32 15:39:37 INFO - PID 12437 | Values: 151.0 111.0 143.0 162.0 112.0 141.0 145.0 116.0 160.0 118.0 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 15:39:37 INFO - PID 12437 | Values: 163.0 166.0 162.0 162.0 162.0 162.0 161.0 163.0 163.0 161.0 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#3] audio-fft Cycles:10 Average:96.60 Median:75.00 stddev:44.76 (59.7%) stddev-sans-first:46.79 15:39:37 INFO - PID 12437 | Values: 75.0 76.0 75.0 183.0 76.0 75.0 77.0 75.0 180.0 74.0 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:77.00 stddev:25.19 (32.7%) stddev-sans-first:26.13 15:39:37 INFO - PID 12437 | Values: 78.0 77.0 135.0 78.0 77.0 77.0 128.0 78.0 77.0 125.0 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 15:39:37 INFO - PID 12437 | Values: 114.0 114.0 113.0 113.0 113.0 114.0 113.0 113.0 114.0 113.0 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:148.50 stddev:2.21 (1.5%) stddev-sans-first:2.30 15:39:37 INFO - PID 12437 | Values: 150.0 147.0 147.0 154.0 148.0 148.0 147.0 147.0 149.0 150.0 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.64 (1.7%) stddev-sans-first:1.72 15:39:37 INFO - PID 12437 | Values: 94.0 94.0 96.0 99.0 94.0 94.0 94.0 94.0 94.0 94.0 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#8] json-parse-financial Cycles:10 Average:48.10 Median:48.50 stddev:2.42 (5.0%) stddev-sans-first:2.54 15:39:37 INFO - PID 12437 | Values: 47.0 49.0 46.0 52.0 45.0 52.0 47.0 48.0 49.0 46.0 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#9] json-stringify-tinderbox Cycles:10 Average:52.80 Median:53.00 stddev:0.63 (1.2%) stddev-sans-first:0.60 15:39:37 INFO - PID 12437 | Values: 52.0 53.0 54.0 52.0 53.0 52.0 53.0 53.0 53.0 53.0 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#10] stanford-crypto-aes Cycles:10 Average:74.40 Median:73.00 stddev:2.99 (4.1%) stddev-sans-first:2.39 15:39:37 INFO - PID 12437 | Values: 80.0 73.0 73.0 73.0 80.0 73.0 73.0 72.0 74.0 73.0 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#11] stanford-crypto-ccm Cycles:10 Average:121.90 Median:123.00 stddev:5.38 (4.4%) stddev-sans-first:5.67 15:39:37 INFO - PID 12437 | Values: 120.0 122.0 116.0 129.0 120.0 119.0 124.0 127.0 113.0 129.0 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.50 stddev:4.45 (2.7%) stddev-sans-first:4.15 15:39:37 INFO - PID 12437 | Values: 168.0 159.0 167.0 164.0 157.0 157.0 168.0 161.0 161.0 158.0 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.20 Median:59.50 stddev:1.14 (1.9%) stddev-sans-first:1.17 15:39:37 INFO - PID 12437 | Values: 60.0 60.0 59.0 60.0 57.0 58.0 59.0 59.0 61.0 59.0 15:39:37 INFO - PID 12437 | -------- Summary: end -------- 15:39:37 INFO - PID 12437 | 15:39:37 INFO - PID 12437 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:39:37 INFO - TEST-INFO | 12437: exit 0 15:39:37 INFO - TEST-OK | kraken | took 59448ms 15:39:37 INFO - SUITE-END | took 1167s 15:39:37 INFO - Completed test suite (00:19:27) 15:39:37 INFO - javascript benchmark 15:39:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9201.242346340041, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3572.8928132156043, 3599.15419876329, 3601.081724160339, 3609.981950090249, 3622.5652921649407, 6413.903791443132, 6440.806775796727, 6476.676166191689, 6512.446442052419, 6513.283538810733, 6436.1311222985, 6469.482441404676, 6535.869282614345, 6540.803775886731, 6546.803595892131, 5506.201600767887, 5516.475934786209, 5547.33431988162, 5653.802116925908, 5679.034564124109, 5554.583406244527, 5654.660720356771, 5656.604037717341, 5680.772769089232, 5695.34503532095, 5518.33779946405, 5564.1931919871395, 5574.888502229973, 5625.128105143709, 5663.093904975205, 5495.917561236584, 5576.832695019115, 5591.8881622367735, 5636.605437619368, 5649.180868774005, 5518.19986102017, 5548.0845660465975, 5577.776888924438, 5591.664500130005, 5610.214569960209, 6224.066390041485, 6313.179286692746, 6316.273628532732, 6381.425671689571, 6415.967920160369, 6868.828279293008, 6934.895976560356, 6958.512904096715, 6967.477439192081, 6989.4408447324095, 6915.550489218235, 6960.65196740161, 7002.054722612433, 7059.0, 7088.751893683696, 6424.0, 6428.77499287532, 6486.189226346707, 6527.771527996545, 6555.410013098844, 7032.789016329519, 7119.4660400470175, 7130.03744494497, 7130.607816570035, 7149.96425017882, 6751.696173672197, 6758.493113016445, 6767.830804229934, 6809.625470599165, 6832.931670683329, 6848.486363522756, 6992.580445173306, 6996.475264355194, 7004.509684322048, 7004.614746188907, 6787.219469760942, 6847.897281540781, 6857.55425897315, 6860.485463590251, 6860.5197636165985, 6848.520603557703, 6857.314268573103, 6867.690953907087, 6898.310168983162, 6908.032875397448, 4974.527419895104, 5067.949320506821, 5070.315507406527, 5087.0, 5096.159133742965, 4520.841770538015, 4556.157110934421, 4563.361129441881, 4571.588557029883, 4577.0, 6524.902126468107, 6593.406593406617, 6611.107500487469, 6680.665966701646, 6682.3317668232785, 6997.440204783605, 6999.580025198505, 7000.404965577983, 7040.084788977502, 7040.295970402919, 6626.635535045522, 6642.501812364092, 6670.099536562502, 6688.531802773759, 6693.832654183684, 5794.246747922827, 5851.941480585139, 5909.025010873243, 5919.4080591940465, 5919.6744179070565, 6962.686679099453, 7051.682674279669, 7112.324329188822, 7182.281771822881, 7224.385927196247, 6972.651367431709, 7054.0, 7055.435565154878, 7062.4703147263135, 7069.22238553769, 7116.5730056194725, 7149.320814522612, 7165.426765858614, 7197.46019048563, 7235.710571577289, 6677.465802735673, 6738.764143254963, 6840.281770414035, 6886.48351373659, 6957.860842783217, 7014.649267536501, 7041.0, 7042.0, 7048.330408611174, 7063.540869843444, 6713.865722685617, 6782.28785977485, 6854.554453960476, 6876.862462750617, 6878.8624227516175, 6653.401193892573, 6744.865102698017, 6752.155980502437, 6765.221999469927, 6774.0, 6734.057231987624, 6740.662966851736, 6759.459243260626, 6762.52662313653, 6766.594004359754, 6758.898616520658, 6802.965985170043, 6805.0, 6875.140607424072, 6887.070245516991, 6534.183227096613, 6620.470362371095, 6632.436242919213, 6633.70148343316, 6719.328067193437], "value": 6321.122802443008, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [883.8879296813686, 918.8208299381623, 928.4243768863304, 981.0532835813439, 982.4301904895161, 42162.0, 42885.57114428855, 43104.0, 43144.0, 43262.35106473398, 39906.0, 40160.39759403611, 40167.0, 40175.0, 40232.0, 7188.065551478314, 7282.0, 7302.05073340465, 7304.379127774119, 7308.196098429195, 7115.0, 7168.569885806843, 7185.173705023937, 7185.748498802543, 7186.065811444531, 7946.523208607502, 8118.959405202966, 8152.062512811014, 8159.918400816005, 8162.224588664097, 7995.600219988977, 8036.517808931483, 8090.919090809105, 8100.189981001941, 8107.0, 7814.53112813233, 7961.522308661441, 7969.123396426388, 7969.800754981114, 8012.439129260954, 41062.178756424706, 41178.0, 41386.79306603448, 41473.58526414757, 41500.1699966002, 3700.3709369407266, 3756.4553139794575, 3765.1151979284846, 3770.9434358484646, 3774.2074164425503, 32343.83828080868, 32357.352852942808, 32521.186970325696, 32548.511772323196, 32715.83642081798, 5202.323697919284, 5255.842324730264, 5258.290130832365, 5263.394709608406, 5296.629235953485, 211142.0, 213846.0, 217339.0, 218383.0, 230459.8477007621, 51679.22481162786, 51700.0, 51880.22179667308, 51965.48034519682, 52083.0, 55126.44873551293, 55567.16649250264, 55589.722051389486, 55654.72172639111, 55816.441835581936, 17953.102344882704, 18157.7276340855, 18206.726899096524, 18208.45374638763, 18283.817161828476, 15022.549323520312, 15077.396904123712, 15130.54608361751, 15189.544313670607, 15235.162066086472, 15017.0, 15208.16355100458, 15409.152496612794, 15521.301541430663, 15653.0, 5966.522678185735, 6010.639361638316, 6177.2587289524645, 6183.876322473526, 6240.656763878031, 1123.1856903744883, 1124.2579897267929, 1127.4306475229957, 1144.4621028116771, 1149.0405511398076, 25738.35654108662, 25796.35509112287, 25832.483350333263, 25917.481650366888, 26085.08702195414, 1240.3674126195524, 1264.6585421936027, 1268.7399083187925, 1277.0613599004723, 1278.571678487717, 13707.314634268247, 17935.820641793674, 18210.726839097424, 18372.81627183738, 18492.630147396976, 301287.0, 301589.0, 302144.0, 304504.0, 305725.0, 62043.37956620466, 62500.687496563136, 62746.37253627405, 62801.0, 63486.36513634897, 1567.7021365940664, 1573.7403328450678, 1589.2212815720213, 1597.5367143528247, 1600.6798640271993, 30668.539971900886, 30864.228394289425, 31074.0, 31307.53038704467, 32212.033638990866, 55921.16118258148, 56331.436685632616, 56452.0, 56780.148297776395, 56884.43115568791, 184111.0, 184964.1503584947, 184990.0, 185291.0, 186130.0, 37151.6284837159, 38170.809145954096, 39106.80446597749, 39209.60790392174, 39460.60539394569, 47192.29211561761, 48354.75822620864, 48422.27366589433, 48605.513944861515, 48753.75623121862, 33755.0, 34528.654713452546, 34939.65060349364, 35045.0, 35262.82368588243, 34731.13172170716, 34752.65247347494, 34807.0, 34913.650863492054, 35044.29911401809, 41463.7926810364, 41723.7913810429, 41905.0, 42257.0, 42442.0, 32960.340793184485, 33400.498992514644, 33505.49741753827, 33637.0, 33692.157696057795, 26185.607215891396, 26533.0, 27210.45579088447, 27234.455310894067, 27422.45155096927], "value": 18967.715268855136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.1322379535636, 578.7916350113961, 579.8550362409397, 580.9128630705396, 619.0837560410592, 23437.414064648372, 24294.75705242947, 24352.147674831383, 24375.14686985958, 24421.0, 25368.873155634195, 27916.0, 28235.15294541162, 28475.85762071192, 28511.57232641512, 6506.804795856132, 6641.203055633331, 6642.036904648823, 6643.534952553323, 6648.0, 6320.0, 6500.9674951625175, 6589.736410543596, 6637.037629543714, 6647.268800431949, 6561.8031459056065, 6575.736970521173, 6580.749657565071, 6585.769498067569, 6596.967015164942, 6587.703553340088, 6597.340265973412, 6601.306862779387, 6609.801705948805, 6643.368879956444, 6099.756009759604, 6124.479419249369, 6151.446369826737, 6157.0, 6166.1983942087245, 31424.214394640087, 31897.0, 32077.1980700482, 32148.678513214803, 32474.512882306783, 2267.807236384909, 2284.383216531544, 2289.97710022901, 2298.402415371999, 2306.8039216666602, 20244.0, 20874.37376878696, 21066.368008959602, 21082.0, 21093.367198984055, 2418.6734790803193, 2424.866632335221, 2474.4556197636493, 2516.8238223324374, 2536.2898388451263, 151195.24402378028, 152748.9999999989, 153612.0, 154039.2298038514, 154387.0, 15968.441104561285, 16482.587935301475, 16574.254158562893, 17044.744328835077, 17124.14379281031, 25986.22041338763, 25998.22005339843, 26017.609735853977, 26050.218493445227, 26073.73926260713, 11424.42877856104, 11632.892731316128, 11687.76624467523, 11755.471003804849, 11887.632922214056, 9905.455199963926, 11083.72290692739, 11194.720131996764, 11267.211295209421, 11522.654320370402, 8805.911940880509, 10088.546015429323, 10146.188304935735, 10369.118624916966, 10451.895481045092, 2954.630671166104, 2956.74867636249, 2958.3343747657036, 2959.7928145030073, 2988.193187839271, 1056.1234175634359, 1091.7379828841022, 1092.7104317355906, 1096.1121491591837, 1098.6868742408376, 22390.664140037912, 22549.774502255095, 22638.547229055326, 22688.773112268995, 22948.082076716746, 1167.0430247197387, 1170.6019953215948, 1175.3887978251262, 1176.253079294654, 1181.4270079011671, 12257.93871030657, 12431.93784031074, 12496.937515312366, 12529.498820047096, 12641.2415255085, 573917.0, 580021.0, 586002.0, 596357.0, 602918.0, 132390.33804831107, 132730.33634831765, 134682.32658836644, 134884.0, 137647.0, 1275.3559452476625, 1310.3644732304824, 1336.6992426704107, 1336.9665758356118, 1337.732453509302, 19382.12780424856, 19610.607787843877, 20085.59828803445, 20120.39638810838, 20218.292359767336, 62200.37799622127, 62928.370716294085, 63822.68088659527, 64319.35680643134, 64675.67662161659, 77406.6129669348, 77737.22262777526, 78116.2188378109, 78144.21855781597, 78408.60795695985, 13766.449342026608, 14252.643683907985, 15303.0, 15800.209989500248, 16285.837141628432, 24169.879150604836, 24478.265652030466, 24542.877285613456, 24610.753892461562, 24614.0, 19077.141528630968, 19308.0, 19548.902255488632, 19621.215151393786, 19628.4297256222, 16853.747193791856, 17090.2309396075, 17220.913895430444, 17326.30694772195, 17749.645007100044, 19486.0, 19558.0, 19683.507912302306, 19859.304924328157, 19902.0, 15847.68304633924, 15878.729701623612, 16061.357545698042, 16127.354905803637, 16178.838211617733, 19776.011199439683, 19874.304399345954, 19998.300059497848, 20026.59946801085, 20066.89632070192], "value": 12995.691149374976, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.8186264469168, 1475.4024620028886, 1486.8959172857903, 1488.1517535005044, 1500.3098574655658, 15653.373865045398, 16002.279897404645, 16388.67222655546, 16401.097939613315, 16403.261853216605, 16950.3219871205, 17185.82814171858, 17241.051742154206, 17247.0, 17267.050312232823, 2867.3261783480866, 2924.488214562454, 2925.956110658342, 2927.912162635114, 2928.2240206345336, 2925.3710452252762, 2966.3029188140767, 2987.1785259053718, 3017.6722242213464, 3066.064850220682, 3050.9626726912843, 3057.2509735114927, 3060.831654259015, 3082.383523295339, 3089.490234111369, 2979.6573394059637, 2980.2847316643956, 3028.515437529996, 3030.10611869499, 3031.4998025325795, 2849.8575071246564, 2894.2619631993916, 2898.347871728844, 2900.622919020535, 2905.4915389806697, 15895.364185432569, 16218.270177842025, 16295.266712997944, 16309.51071467858, 16316.184190790531, 8453.281471074966, 8660.0, 8738.694145704934, 8762.518061506615, 8781.780455488664, 5359.330083739533, 5610.410906854762, 5726.9713651431475, 5731.426857314277, 5734.655920644733, 1987.1951859496926, 2014.8287395571394, 2016.5059560407647, 2065.493953981284, 2072.2954195573425, 28040.0, 28345.71654283472, 28401.85799071012, 28408.289792755346, 28428.573571396446, 7292.3801476874, 7328.9267107329315, 7446.0, 7588.0, 7603.46775725705, 19099.61800764005, 19314.32399865998, 19321.323753668556, 19346.0, 19355.0, 8517.829643407098, 8664.0, 8669.869951950726, 8681.6527338907, 8695.217430431165, 8021.639026243833, 8024.2376974187355, 8088.636011379502, 8090.838183236302, 8124.7562573122905, 5794.855128621818, 5973.223480947449, 5983.700814959322, 6044.335123136451, 6091.604045737013, 1616.8625666818452, 1646.7694522766822, 1669.5992961689108, 1726.3871325679454, 1801.261482792049, 985.5417230987482, 999.7400675824338, 1001.3140998416109, 1006.3861044762689, 1021.8671572695501, 9568.521573921415, 9779.755506112262, 9963.402195868272, 9974.202063834875, 10027.398356098658, 1068.56188962525, 1089.3028461784463, 1092.8306112552566, 1094.1574987259764, 1097.078454098561, 5792.88414231713, 6213.937860621426, 6260.780872669526, 6279.968600157062, 6401.775937842246, 23275.301740947798, 23871.880640596686, 23944.88027559851, 24021.159259425836, 24057.879710601686, 22226.333210003402, 23474.64788028181, 23638.763612363655, 23853.403664908168, 23888.761112388653, 12172.81740773889, 12218.389080545938, 12284.078694097978, 12370.81443778344, 12429.875701243052, 9618.682940449158, 9891.406515609087, 9974.202063834731, 10053.74328208974, 10393.532291047073, 20255.4936126598, 20373.694394583796, 20498.975051247675, 20987.580248394643, 21232.681509777056, 20893.686594701394, 21061.157553698293, 21305.573888521834, 21384.144634214455, 21626.567468650224, 13349.466021359036, 13687.931560342135, 13700.520481783089, 13700.725985480434, 13741.24423156736, 14853.257337133316, 14916.925415372854, 14918.403263869324, 14978.775318370452, 15027.549173524812, 11795.764084718428, 11909.106816988933, 11909.642710718692, 12062.75874482523, 12242.510299588273, 11270.267432616854, 11637.0, 11690.240134391237, 11721.06231501495, 12091.81862272049, 10910.454477275945, 11141.498632561716, 11142.777144457228, 11155.05182059534, 11155.330680158891, 8120.309773669304, 8169.428140030141, 8289.461185022954, 8378.706745263886, 8392.958035209786, 8294.0, 8419.115992820665, 8427.705030323908, 8453.450525715809, 8472.66109355619], "value": 7399.112534136626, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.9474052594743, 534.684536123687, 556.5352930303196, 562.7411390760251, 570.386834153285, 6302.369763023707, 6315.684215789215, 6337.778177763779, 6358.80923572293, 6374.418360563967, 6256.874862502747, 6257.873582755103, 6257.937420625793, 6283.371662833726, 6300.164925783404, 4832.202686556731, 4938.629602779788, 5005.299258103868, 5019.874503137415, 5051.974740126294, 4932.679375840559, 4937.321310754342, 4941.851744447672, 4943.752812359386, 4955.504449555034, 4825.0, 4886.218205087187, 4891.584215341701, 4897.436794768611, 4902.19113846215, 4854.757262136879, 4868.513148685139, 4897.926531102018, 4937.111319962405, 4940.827071052496, 4431.800568974404, 4435.667324950641, 4487.573680500347, 4494.303382975644, 4533.750643714594, 6064.0, 6096.817095487142, 6100.481459075984, 6112.724927378279, 6135.754569817202, 5877.177195192677, 5896.941030589725, 5903.586748927577, 5927.970360148215, 5934.406559344031, 6730.596164230113, 6744.527883048188, 6750.1562304711915, 6810.990757726483, 6841.008053832216, 5061.797528098871, 5073.949260507385, 5074.644774865761, 5087.160618497944, 5097.847064588068, 6735.696893639798, 6856.52004359695, 6968.547044442095, 7027.43780497559, 7028.508004439691, 5192.350956130484, 5231.869203269873, 5235.377033119745, 5259.789608415621, 5262.210668399771, 5252.868678283074, 5271.288376069181, 5280.498352656491, 5343.3587969443915, 5343.7060961647485, 5859.1797148399255, 5873.618214816023, 5896.3219229788265, 5913.704314784243, 5929.6145750526075, 6739.0, 6753.3921947025, 6779.186497620317, 6813.761518346834, 6816.965915170393, 1847.464235371754, 1860.9720854187199, 1866.2348437140706, 1866.4400679796279, 1869.7662792150982, 1266.4554241676167, 1283.140296001681, 1309.8428188617427, 1317.8286822713178, 1318.3276528970293, 6453.1610890583925, 6493.902591461132, 6508.739650414025, 6524.9673751630935, 6578.572392794453, 6704.229013663491, 6738.3491044694365, 6863.313668633196, 6889.517733758589, 6996.265392133854, 6418.935810641834, 6425.325340839238, 6425.678716064178, 6451.645159516272, 6468.611883287018, 3658.579263384745, 3672.8347224374966, 3687.686546643565, 3695.796731179757, 3701.3522633539023, 7052.637366482183, 7086.716531338792, 7090.503664743522, 7092.687852747258, 7101.467389945775, 6979.511434199659, 6997.755078572225, 7047.330503602149, 7060.6469676517, 7149.964250178716, 6906.654667266516, 6923.896141557881, 6978.616176110363, 6991.999999999898, 7071.611061391673, 6806.557573757888, 6838.658067096725, 6860.622665753432, 6919.654017299215, 6930.232790638355, 6654.866902662016, 6686.53194276396, 6773.0, 6795.354441328066, 6802.292750451115, 6924.446044316342, 7016.36852683261, 7019.964900175466, 7071.055459748404, 7102.502824802421, 5246.2392953020835, 5278.762455689426, 5293.9205911910585, 5313.52178303939, 5348.1442969124755, 6542.738290468328, 6673.1992160941, 6894.689738961659, 6950.513464057467, 6984.965075174591, 6719.3873470367735, 6725.49558783103, 6725.529212955242, 6734.797956061326, 6740.9325906740305, 6521.445677117498, 6649.202095748541, 6692.096566963398, 6695.296993815774, 6715.3547380892, 6493.415592596689, 6557.114789503356, 6622.503312251504, 6628.602283862983, 6640.90038649411, 6649.301823308483, 6659.367360100783, 6661.367170118831, 6691.297413771484, 6728.428083612752, 6479.643619600967, 6510.9674451629335, 6521.250056243593, 6527.0, 6558.508111891722], "value": 5230.212764699054, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [956.3353469338808, 961.6105477281699, 992.3995982430629, 1007.7027276953298, 1014.2089170447053, 19042.428727138173, 19143.712844307345, 19355.22579096836, 19363.903180484114, 21972.230971915986, 21951.0, 22460.775392246072, 22547.887260563715, 22631.66052509214, 22640.320790376314, 1013.3818370793829, 1032.3444612670971, 1032.7160030991463, 1034.2501686277426, 1036.984445233322, 1079.4386918802218, 1108.894655007773, 1112.3048094940661, 1117.5753213778753, 1118.3960661242918, 1181.5569161564413, 1183.5384200161943, 1183.8224266360028, 1184.8992835608983, 1185.4250688416112, 1166.6966588686917, 1168.9649310520697, 1170.1750266062406, 1170.7951108556053, 1171.6309362550812, 852.7313896122702, 854.9957250213771, 855.7389996051202, 857.014433401587, 858.5449711652834, 20366.083526241353, 20407.183712651477, 20478.590428191354, 20673.5865282695, 20997.895010525004, 20868.495780506437, 20995.0, 21549.67675484869, 21611.243606473698, 21859.12563497458, 15919.522414327588, 15964.361425542964, 16058.0, 17101.657966840718, 17641.470755877344, 3756.0, 3777.9433308500393, 3781.4138808484727, 3784.3377408953597, 3788.052986753312, 144375.27812360975, 144992.0, 145803.0, 146307.0, 146468.0, 16249.59376015609, 16537.0, 16740.079295638858, 16756.83243167577, 16782.496525104267, 30561.541576876363, 31274.214270360055, 32035.35929281448, 32236.03291901247, 32236.516452253236, 9372.5313734313, 9537.189338906272, 9588.856167157359, 9596.90403095974, 9626.326157169071, 4493.370928070073, 4582.221022426195, 4604.700694454849, 4616.60758835496, 4628.722276663344, 5780.595358324961, 5894.67579283135, 5903.498202652822, 5912.083627037816, 5920.674362910081, 1150.8676502202354, 1161.517970042423, 1182.6274723462082, 1186.851643544557, 1188.3879801902028, 740.4039748002801, 755.4371992865241, 767.2672597669213, 769.0886299734832, 773.014406631538, 12435.129540932048, 13138.802917956238, 13284.402201900937, 13295.73408531824, 13317.933410332886, 738.1363804348924, 753.6947536247828, 757.75373003774, 770.5030255485293, 772.0195351903163, 5596.748146333425, 5667.489925906688, 5669.262995810601, 5752.482276595043, 5834.154047663065, 126518.0, 130763.34618326847, 130819.0, 131217.0, 137099.31450342684, 113246.0, 114281.0, 114596.0, 114637.0, 115861.42069289599, 101562.49218754006, 103464.0, 104152.47923760333, 107198.0, 108269.45865270623, 13649.0, 13971.790423143457, 13996.44014239419, 14290.0, 14329.928350358181, 45968.0, 46985.29522057103, 47806.0, 48548.0, 49314.0, 82977.58511207406, 83121.0, 83869.58065209635, 84702.0, 87897.80255493664, 20321.0, 20760.79239207649, 20853.165873365502, 20882.477938051063, 21026.369208923756, 22331.77668223297, 22365.888170559043, 22455.66316505221, 23018.53962920766, 23162.652560211274, 20273.29043483471, 20738.688919665914, 20904.16383344649, 21510.354689359345, 21844.126234951058, 18312.0, 18773.530661733566, 20022.499437513598, 21172.364829055154, 21383.893080534497, 19543.902280488506, 19648.410547683594, 19675.508112297306, 19707.70438443453, 19863.60272794565, 14352.56942291733, 14671.413143474141, 14894.478693245685, 15083.622909427351, 15224.46714364992, 14489.275536223358, 14697.85302146965, 15013.099214047192, 15056.623584410478, 15096.094234345974], "value": 10063.394391533833, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1468.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 106.0, 101.0, 106.0, 105.0, 108.0, 112.0, 98.0, 110.0, 110.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 111.0, 143.0, 162.0, 112.0, 141.0, 145.0, 116.0, 160.0, 118.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 162.0, 162.0, 162.0, 162.0, 161.0, 163.0, 163.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 183.0, 76.0, 75.0, 77.0, 75.0, 180.0, 74.0], "value": 96.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 135.0, 78.0, 77.0, 77.0, 128.0, 78.0, 77.0, 125.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 147.0, 154.0, 148.0, 148.0, 147.0, 147.0, 149.0, 150.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 99.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 49.0, 46.0, 52.0, 45.0, 52.0, 47.0, 48.0, 49.0, 46.0], "value": 48.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 54.0, 52.0, 53.0, 52.0, 53.0, 53.0, 53.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 73.0, 73.0, 73.0, 80.0, 73.0, 73.0, 72.0, 74.0, 73.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 122.0, 116.0, 129.0, 120.0, 119.0, 124.0, 127.0, 113.0, 129.0], "value": 121.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 159.0, 167.0, 164.0, 157.0, 157.0, 168.0, 161.0, 161.0, 158.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 57.0, 58.0, 59.0, 59.0, 61.0, 59.0], "value": 59.2, "unit": "score"}]}]} 15:39:37 INFO - Return code: 0 15:39:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:39:37 INFO - # TBPL SUCCESS # 15:39:37 INFO - Running post-action listener: _package_coverage_data 15:39:37 INFO - Running post-action listener: _resource_record_post_action 15:39:37 INFO - [mozharness: 2017-08-09 22:39:37.841354Z] Finished run-tests step (success) 15:39:37 INFO - Running post-run listener: _resource_record_post_run 15:39:37 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 499712; Write bytes: 381333504; Read time: 40; Write time: 280136 15:39:37 INFO - TinderboxPrint: CPU usage
13.0% 15:39:37 INFO - TinderboxPrint: I/O read bytes / time
499,712 / 40 15:39:37 INFO - TinderboxPrint: I/O write bytes / time
381,333,504 / 280,136 15:39:37 INFO - TinderboxPrint: CPU idle
8,204.0 (87.0%) 15:39:37 INFO - TinderboxPrint: CPU user
1,181.3 (12.5%) 15:39:37 INFO - TinderboxPrint: Swap in / out
0 / 0 15:39:37 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 77819904; Read time: 0; Write time: 32364 15:39:37 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:39:37 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 495616; Write bytes: 272797696; Read time: 28; Write time: 174068 15:39:38 INFO - Running post-run listener: _upload_blobber_files 15:39:38 INFO - Blob upload gear active. 15:39:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:39:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:39:38 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'] 15:39:38 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 15:39:38 INFO - (blobuploader) - INFO - Open directory for files ... 15:39:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:39:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:39:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:40 INFO - (blobuploader) - INFO - Done attempting. 15:39:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:39:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:39:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:40 INFO - (blobuploader) - INFO - Done attempting. 15:39:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:39:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:39:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:47 INFO - (blobuploader) - INFO - Done attempting. 15:39:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:39:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:39:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:39:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:39:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:39:48 INFO - (blobuploader) - INFO - Done attempting. 15:39:48 INFO - (blobuploader) - INFO - Iteration through files over. 15:39:48 INFO - Return code: 0 15:39:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:39:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:39:48 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/893dc07aca57dc335f223cbd0b9c074dc2b289186dad949327f97c45c4a1f9362caecf7f5dba57a41e53e7a0f8951954fbef11fffd4b101f0de6419c69108cfc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e653e104e5f928da9643e0ceacd8af8b37cd7e618b5fd952dc97c4646f383a55d3ee8f703fcdc10d801f3b44d736d1ff98b8eb2638eff13c101e6ade260a3b8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/495015ef9e584a8c5da3666d30c2c054f0c17ea5b00dd206f28eb1475e6697403fc0fd3968645c8fbba45b9a69cb30c1426ad9f3147435c3d802b17b84f4c0fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/59aa440286c8e7d3431df8f8187232931422f5c62f891c9745bdcbd9adfd6066132f46b10ecca0ec62daebf3b5d779af5b176c0dd0a12cdaa4f740c37e9b7335"} 15:39:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:39:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:39:48 INFO - Contents: 15:39:48 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/893dc07aca57dc335f223cbd0b9c074dc2b289186dad949327f97c45c4a1f9362caecf7f5dba57a41e53e7a0f8951954fbef11fffd4b101f0de6419c69108cfc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e653e104e5f928da9643e0ceacd8af8b37cd7e618b5fd952dc97c4646f383a55d3ee8f703fcdc10d801f3b44d736d1ff98b8eb2638eff13c101e6ade260a3b8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/495015ef9e584a8c5da3666d30c2c054f0c17ea5b00dd206f28eb1475e6697403fc0fd3968645c8fbba45b9a69cb30c1426ad9f3147435c3d802b17b84f4c0fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/59aa440286c8e7d3431df8f8187232931422f5c62f891c9745bdcbd9adfd6066132f46b10ecca0ec62daebf3b5d779af5b176c0dd0a12cdaa4f740c37e9b7335"} 15:39:48 INFO - Running post-run listener: copy_logs_to_upload_dir 15:39:48 INFO - Copying logs to upload dir... 15:39:48 INFO - mkdir: /builds/slave/test/build/upload/logs 15:39:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.322700 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-08-09 15:39:48.433746) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 15:39:48.438162) ========= 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=836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334 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/893dc07aca57dc335f223cbd0b9c074dc2b289186dad949327f97c45c4a1f9362caecf7f5dba57a41e53e7a0f8951954fbef11fffd4b101f0de6419c69108cfc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e653e104e5f928da9643e0ceacd8af8b37cd7e618b5fd952dc97c4646f383a55d3ee8f703fcdc10d801f3b44d736d1ff98b8eb2638eff13c101e6ade260a3b8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/495015ef9e584a8c5da3666d30c2c054f0c17ea5b00dd206f28eb1475e6697403fc0fd3968645c8fbba45b9a69cb30c1426ad9f3147435c3d802b17b84f4c0fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/59aa440286c8e7d3431df8f8187232931422f5c62f891c9745bdcbd9adfd6066132f46b10ecca0ec62daebf3b5d779af5b176c0dd0a12cdaa4f740c37e9b7335"} build_url:https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/T0v6dT-NQJCPoWIEJ0-MGA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/893dc07aca57dc335f223cbd0b9c074dc2b289186dad949327f97c45c4a1f9362caecf7f5dba57a41e53e7a0f8951954fbef11fffd4b101f0de6419c69108cfc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/e653e104e5f928da9643e0ceacd8af8b37cd7e618b5fd952dc97c4646f383a55d3ee8f703fcdc10d801f3b44d736d1ff98b8eb2638eff13c101e6ade260a3b8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/495015ef9e584a8c5da3666d30c2c054f0c17ea5b00dd206f28eb1475e6697403fc0fd3968645c8fbba45b9a69cb30c1426ad9f3147435c3d802b17b84f4c0fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/59aa440286c8e7d3431df8f8187232931422f5c62f891c9745bdcbd9adfd6066132f46b10ecca0ec62daebf3b5d779af5b176c0dd0a12cdaa4f740c37e9b7335"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 15:39:48.470874) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 15:39:48.471232) ========= 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=836cfdc75598d54cb747368e000001a9-1502316412.46740-1280987334 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 15:39:48.547603) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 15:39:48.550932) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 15:39:48.551222) ========= ========= Total master_lag: 0.21 =========