builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1501197095.8 results: success (0) revision: 0379882c11f6d72f11d265036fc815e73b9ef5b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 16:11:35.805389) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 16:11:35.805751) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 16:11:35.806028) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 16:11:35.871923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:11:35.872177) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-27 16:11:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.4M=0s 2017-07-27 16:11:36 (42.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081151 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:11:35.968475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:11:35.968782) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018020 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:11:36.021787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-07-27 16:11:36.023059) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0379882c11f6d72f11d265036fc815e73b9ef5b2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 0379882c11f6d72f11d265036fc815e73b9ef5b2 --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=e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-27 16:11:36,569 truncating revision to first 12 chars 2017-07-27 16:11:36,569 Setting DEBUG logging. 2017-07-27 16:11:36,569 attempt 1/10 2017-07-27 16:11:36,569 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0379882c11f6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-27 16:11:38,029 attempt 1/10 2017-07-27 16:11:38,540 current task status: no status available at this point. state: STARTED 2017-07-27 16:11:38,540 sleeping for 9.00s (attempt 1/10) 2017-07-27 16:11:47,550 attempt 2/10 2017-07-27 16:11:47,911 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-07-27 16:11:48,109 unpacking tar archive at: mozilla-central-0379882c11f6/testing/mozharness/ program finished with exit code 0 elapsedTime=11.874959 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 11 secs) (at 2017-07-27 16:11:47.909998) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 16:11:47.910401) ========= script_repo_revision: 0379882c11f6d72f11d265036fc815e73b9ef5b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 16:11:47.910816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 16:11:47.911091) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 16:11:47.918305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-27 16:11:47.918574) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:11:48 INFO - MultiFileLogger online at 20170727 16:11:48 in /builds/slave/test 16:11:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:11:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:11:48 INFO - {'append_to_log': False, 16:11:48 INFO - 'base_work_dir': '/builds/slave/test', 16:11:48 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:11:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:11:48 INFO - 'branch': 'Firefox-Non-PGO', 16:11:48 INFO - 'buildbot_json_path': 'buildprops.json', 16:11:48 INFO - 'code_coverage': False, 16:11:48 INFO - 'config_files': ('talos/linux_config.py',), 16:11:48 INFO - 'default_actions': ('clobber', 16:11:48 INFO - 'read-buildbot-config', 16:11:48 INFO - 'download-and-extract', 16:11:48 INFO - 'populate-webroot', 16:11:48 INFO - 'create-virtualenv', 16:11:48 INFO - 'install', 16:11:48 INFO - 'setup-mitmproxy', 16:11:48 INFO - 'run-tests'), 16:11:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:11:48 INFO - 'disable_ccov_upload': False, 16:11:48 INFO - 'download_minidump_stackwalk': True, 16:11:48 INFO - 'download_symbols': 'ondemand', 16:11:48 INFO - 'enable_stylo': False, 16:11:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:11:48 INFO - 'tooltool.py': '/tools/tooltool.py', 16:11:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:11:48 INFO - '/tools/misc-python/virtualenv.py')}, 16:11:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:11:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:11:48 INFO - 'gecko_profile': False, 16:11:48 INFO - 'gecko_profile_interval': 0, 16:11:48 INFO - 'installer_path': 'installer.exe', 16:11:48 INFO - 'log_level': 'info', 16:11:48 INFO - 'log_name': 'talos', 16:11:48 INFO - 'log_to_console': True, 16:11:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:11:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:11:48 INFO - 'opt_config_files': (), 16:11:48 INFO - 'pip_index': False, 16:11:48 INFO - 'suite': 'dromaeojs-e10s', 16:11:48 INFO - 'system_bits': '32', 16:11:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:11:48 INFO - 'title': 'talos-linux64-ix-067', 16:11:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:11:48 INFO - 'use_talos_json': True, 16:11:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:11:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:11:48 INFO - 'work_dir': 'build'} 16:11:48 INFO - [mozharness: 2017-07-27 23:11:48.570541Z] Running clobber step. 16:11:48 INFO - Running pre-action listener: _resource_record_pre_action 16:11:48 INFO - Running main action method: clobber 16:11:48 INFO - rmtree: /builds/slave/test/build 16:11:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:11:49 INFO - Running post-action listener: _resource_record_post_action 16:11:49 INFO - [mozharness: 2017-07-27 23:11:49.617558Z] Finished clobber step (success) 16:11:49 INFO - [mozharness: 2017-07-27 23:11:49.617661Z] Running read-buildbot-config step. 16:11:49 INFO - Running pre-action listener: _resource_record_pre_action 16:11:49 INFO - Running main action method: read_buildbot_config 16:11:49 INFO - Using buildbot properties: 16:11:49 INFO - { 16:11:49 INFO - "project": "", 16:11:49 INFO - "product": "firefox", 16:11:49 INFO - "who": "mh@glandium.org", 16:11:49 INFO - "installer_path": "public/build/target.tar.bz2", 16:11:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:11:49 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:11:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:11:49 INFO - "stage_platform": "linux64", 16:11:49 INFO - "basedir": "/builds/slave/test", 16:11:49 INFO - "buildnumber": 1037, 16:11:49 INFO - "platform": "ubuntu64_hw", 16:11:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:11:49 INFO - "slavebuilddir": "test", 16:11:49 INFO - "taskId": "GlP1FPr2T0qQwXqdQhxWOg", 16:11:49 INFO - "branch": "mozilla-central", 16:11:49 INFO - "script_repo_revision": "production", 16:11:49 INFO - "revision": "0379882c11f6d72f11d265036fc815e73b9ef5b2", 16:11:49 INFO - "slavename": "talos-linux64-ix-067", 16:11:49 INFO - "repo_path": "mozilla-central" 16:11:49 INFO - } 16:11:49 INFO - Finding installer, test and symbols from parent task. 16:11:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GlP1FPr2T0qQwXqdQhxWOg'}, attempt #1 16:11:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GlP1FPr2T0qQwXqdQhxWOg'}, attempt #1 16:11:50 INFO - Task dependencies: ZqZj14WcSnmyjGd7pzYZYQ 16:11:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ'}, attempt #1 16:11:51 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2 16:11:51 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/test_packages.json 16:11:51 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.crashreporter-symbols.zip 16:11:51 INFO - Running post-action listener: _resource_record_post_action 16:11:51 INFO - [mozharness: 2017-07-27 23:11:51.004370Z] Finished read-buildbot-config step (success) 16:11:51 INFO - [mozharness: 2017-07-27 23:11:51.004593Z] Running download-and-extract step. 16:11:51 INFO - Running pre-action listener: _resource_record_pre_action 16:11:51 INFO - Running main action method: download_and_extract 16:11:51 INFO - mkdir: /builds/slave/test/build/tests 16:11: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')]} 16:11:51 INFO - trying https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.test_packages.json 16:11:51 INFO - Downloading https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:11:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:11:51 INFO - Downloaded 989 bytes. 16:11:51 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:11:51 INFO - Using the following test package requirements: 16:11:51 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:11:51 INFO - u'common': [u'target.common.tests.zip'], 16:11:51 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:11:51 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:11:51 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:11:51 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:11:51 INFO - u'mozbase': [u'target.common.tests.zip'], 16:11:51 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:11:51 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:11:51 INFO - u'web-platform': [u'target.common.tests.zip', 16:11:51 INFO - u'target.web-platform.tests.tar.gz'], 16:11:51 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:11:51 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:11:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.common.tests.zip 16:11:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:11:51 INFO - Fetch https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.common.tests.zip into memory 16:11:53 INFO - Content-Length response header: 72558369 16:11:53 INFO - Bytes received: 72558369 16:12:04 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:12:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.common.tests.zip 16:12:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:12:04 INFO - Fetch https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.common.tests.zip into memory 16:12:05 INFO - Content-Length response header: 72558369 16:12:05 INFO - Bytes received: 72558369 16:12:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.talos.tests.zip 16:12:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:12:18 INFO - Fetch https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.talos.tests.zip into memory 16:12:19 INFO - Content-Length response header: 14496465 16:12:19 INFO - Bytes received: 14496465 16:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:19 INFO - trying https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2 16:12:19 INFO - Downloading https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:12:22 INFO - Downloaded 62158492 bytes. 16:12:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2 16:12:22 INFO - mkdir: /builds/slave/test/properties 16:12:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:12:22 INFO - Writing to file /builds/slave/test/properties/build_url 16:12:22 INFO - Contents: 16:12:22 INFO - build_url:https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2 16:12:22 INFO - Running post-action listener: _resource_record_post_action 16:12:22 INFO - Running post-action listener: set_extra_try_arguments 16:12:22 INFO - [mozharness: 2017-07-27 23:12:22.057975Z] Finished download-and-extract step (success) 16:12:22 INFO - [mozharness: 2017-07-27 23:12:22.058206Z] Running populate-webroot step. 16:12:22 INFO - Running pre-action listener: _resource_record_pre_action 16:12:22 INFO - Running main action method: populate_webroot 16:12:22 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:12:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:12:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:12:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:12:22 INFO - 'tests': ['damp', 'tps']}, 16:12:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:12:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:12:22 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:12:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:12:22 INFO - 'other-e10s': {'tests': ['a11yr', 16:12:22 INFO - 'ts_paint', 16:12:22 INFO - 'tpaint', 16:12:22 INFO - 'sessionrestore', 16:12:22 INFO - 'sessionrestore_many_windows', 16:12:22 INFO - 'sessionrestore_no_auto_restore', 16:12:22 INFO - 'tabpaint']}, 16:12:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:12:22 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:12:22 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:12:22 INFO - 'talos_options': ['--mitmproxy', 16:12:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:12:22 INFO - '--firstNonBlankPaint'], 16:12:22 INFO - 'tests': ['quantum_pageload_google', 16:12:22 INFO - 'quantum_pageload_youtube', 16:12:22 INFO - 'quantum_pageload_amazon', 16:12:22 INFO - 'quantum_pageload_facebook']}, 16:12:22 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:12:22 INFO - 'talos_options': ['--stylo', 16:12:22 INFO - '--mitmproxy', 16:12:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:12:22 INFO - '--firstNonBlankPaint'], 16:12:22 INFO - 'tests': ['quantum_pageload_google', 16:12:22 INFO - 'quantum_pageload_youtube', 16:12:22 INFO - 'quantum_pageload_amazon', 16:12:22 INFO - 'quantum_pageload_facebook']}, 16:12:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:12:22 INFO - 'tsvgr_opacity', 16:12:22 INFO - 'tart', 16:12:22 INFO - 'tscrollx', 16:12:22 INFO - 'cart', 16:12:22 INFO - 'tsvg_static']}, 16:12:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:12:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:12:22 INFO - 'talos_options': ['--xperf_path', 16:12:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:22 INFO - 'tests': ['tp5n']}}} 16:12:22 INFO - Running post-action listener: _resource_record_post_action 16:12:22 INFO - [mozharness: 2017-07-27 23:12:22.074713Z] Finished populate-webroot step (success) 16:12:22 INFO - [mozharness: 2017-07-27 23:12:22.074804Z] Running create-virtualenv step. 16:12:22 INFO - Running pre-action listener: _resource_record_pre_action 16:12:22 INFO - Running main action method: create_virtualenv 16:12:22 INFO - Creating virtualenv /builds/slave/test/build/venv 16:12:22 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 16:12:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:12:22 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:12:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:12:22 INFO - Using real prefix '/usr' 16:12:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:12:22 INFO - Installing distribute.............................................................................................................................................................................................done. 16:12:24 INFO - Installing pip.................done. 16:12:24 INFO - Return code: 0 16:12:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:12:24 INFO - Reading from file tmpfile_stdout 16:12:24 INFO - Output received: 16:12:24 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) 16:12:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1358eb0>, '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 0x1359db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135a240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', '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 16:12:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:12:24 INFO - Using env: {'DISPLAY': ':0', 16:12:24 INFO - 'HOME': '/home/cltbld', 16:12:24 INFO - 'LANG': 'en_US.UTF-8', 16:12:24 INFO - 'LANGUAGE': 'en_US:en', 16:12:24 INFO - 'LOGNAME': 'cltbld', 16:12:24 INFO - 'MAIL': '/var/mail/cltbld', 16:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:24 INFO - 'MOZ_NO_REMOTE': '1', 16:12:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:24 INFO - 'NO_EM_RESTART': '1', 16:12:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:24 INFO - 'PWD': '/builds/slave/test', 16:12:24 INFO - 'SHELL': '/bin/bash', 16:12:24 INFO - 'SHLVL': '1', 16:12:24 INFO - 'TERM': 'linux', 16:12:24 INFO - 'TMOUT': '86400', 16:12:24 INFO - 'USER': 'cltbld', 16:12:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', 16:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:24 INFO - '_': '/tools/buildbot/bin/python'} 16:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:25 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 16:12:25 INFO - Cleaning up... 16:12:25 INFO - Return code: 0 16:12:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:12:25 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')]} 16:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:25 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')]} 16:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:25 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1358eb0>, '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 0x1359db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135a240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', '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 16:12:25 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 16:12:25 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 16:12:25 INFO - Using env: {'DISPLAY': ':0', 16:12:25 INFO - 'HOME': '/home/cltbld', 16:12:25 INFO - 'LANG': 'en_US.UTF-8', 16:12:25 INFO - 'LANGUAGE': 'en_US:en', 16:12:25 INFO - 'LOGNAME': 'cltbld', 16:12:25 INFO - 'MAIL': '/var/mail/cltbld', 16:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:25 INFO - 'MOZ_NO_REMOTE': '1', 16:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:25 INFO - 'NO_EM_RESTART': '1', 16:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:25 INFO - 'PWD': '/builds/slave/test', 16:12:25 INFO - 'SHELL': '/bin/bash', 16:12:25 INFO - 'SHLVL': '1', 16:12:25 INFO - 'TERM': 'linux', 16:12:25 INFO - 'TMOUT': '86400', 16:12:25 INFO - 'USER': 'cltbld', 16:12:25 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', 16:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:25 INFO - '_': '/tools/buildbot/bin/python'} 16:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:25 INFO - Downloading/unpacking psutil>=3.1.1 16:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:12:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:26 INFO - Installing collected packages: psutil 16:12:26 INFO - Running setup.py install for psutil 16:12:26 INFO - building 'psutil._psutil_linux' extension 16:12:26 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 16:12:26 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 16:12:26 INFO - building 'psutil._psutil_posix' extension 16:12:26 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 16:12:26 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 16:12:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:26 INFO - Successfully installed psutil 16:12:26 INFO - Cleaning up... 16:12:27 INFO - Return code: 0 16:12:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:12:27 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')]} 16:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:27 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')]} 16:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:27 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1358eb0>, '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 0x1359db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135a240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', '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 16:12:27 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 16:12:27 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 16:12:27 INFO - Using env: {'DISPLAY': ':0', 16:12:27 INFO - 'HOME': '/home/cltbld', 16:12:27 INFO - 'LANG': 'en_US.UTF-8', 16:12:27 INFO - 'LANGUAGE': 'en_US:en', 16:12:27 INFO - 'LOGNAME': 'cltbld', 16:12:27 INFO - 'MAIL': '/var/mail/cltbld', 16:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:27 INFO - 'MOZ_NO_REMOTE': '1', 16:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:27 INFO - 'NO_EM_RESTART': '1', 16:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:27 INFO - 'PWD': '/builds/slave/test', 16:12:27 INFO - 'SHELL': '/bin/bash', 16:12:27 INFO - 'SHLVL': '1', 16:12:27 INFO - 'TERM': 'linux', 16:12:27 INFO - 'TMOUT': '86400', 16:12:27 INFO - 'USER': 'cltbld', 16:12:27 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', 16:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:27 INFO - '_': '/tools/buildbot/bin/python'} 16:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:12:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:12:28 INFO - Installing collected packages: mozsystemmonitor 16:12:28 INFO - Running setup.py install for mozsystemmonitor 16:12:28 INFO - Successfully installed mozsystemmonitor 16:12:28 INFO - Cleaning up... 16:12:28 INFO - Return code: 0 16:12:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:12:28 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')]} 16:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:28 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')]} 16:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:28 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1358eb0>, '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 0x1359db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135a240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', '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 16:12:28 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 16:12:28 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 16:12:28 INFO - Using env: {'DISPLAY': ':0', 16:12:28 INFO - 'HOME': '/home/cltbld', 16:12:28 INFO - 'LANG': 'en_US.UTF-8', 16:12:28 INFO - 'LANGUAGE': 'en_US:en', 16:12:28 INFO - 'LOGNAME': 'cltbld', 16:12:28 INFO - 'MAIL': '/var/mail/cltbld', 16:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:28 INFO - 'MOZ_NO_REMOTE': '1', 16:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:28 INFO - 'NO_EM_RESTART': '1', 16:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:28 INFO - 'PWD': '/builds/slave/test', 16:12:28 INFO - 'SHELL': '/bin/bash', 16:12:28 INFO - 'SHLVL': '1', 16:12:28 INFO - 'TERM': 'linux', 16:12:28 INFO - 'TMOUT': '86400', 16:12:28 INFO - 'USER': 'cltbld', 16:12:28 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', 16:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:28 INFO - '_': '/tools/buildbot/bin/python'} 16:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:28 INFO - Downloading/unpacking jsonschema==2.5.1 16:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:12:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:12:29 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 16:12:29 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 16:12:29 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 16:12:29 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 16:12:29 INFO - Downloading functools32-3.2.3-2.tar.gz 16:12:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:12:30 INFO - warning: no files found matching '*.txt' 16:12:30 INFO - no previously-included directories found matching 'build' 16:12:30 INFO - no previously-included directories found matching 'dist' 16:12:30 INFO - no previously-included directories found matching '.git*' 16:12:30 INFO - Installing collected packages: jsonschema, functools32 16:12:30 INFO - Running setup.py install for functools32 16:12:30 INFO - warning: no files found matching '*.txt' 16:12:30 INFO - no previously-included directories found matching 'build' 16:12:30 INFO - no previously-included directories found matching 'dist' 16:12:30 INFO - no previously-included directories found matching '.git*' 16:12:30 INFO - Successfully installed jsonschema functools32 16:12:30 INFO - Cleaning up... 16:12:30 INFO - Return code: 0 16:12:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:12:30 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')]} 16:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:30 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')]} 16:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:30 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1358eb0>, '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 0x1359db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135a240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', '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 16:12:30 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 16:12:30 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 16:12:30 INFO - Using env: {'DISPLAY': ':0', 16:12:30 INFO - 'HOME': '/home/cltbld', 16:12:30 INFO - 'LANG': 'en_US.UTF-8', 16:12:30 INFO - 'LANGUAGE': 'en_US:en', 16:12:30 INFO - 'LOGNAME': 'cltbld', 16:12:30 INFO - 'MAIL': '/var/mail/cltbld', 16:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:30 INFO - 'MOZ_NO_REMOTE': '1', 16:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:30 INFO - 'NO_EM_RESTART': '1', 16:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:30 INFO - 'PWD': '/builds/slave/test', 16:12:30 INFO - 'SHELL': '/bin/bash', 16:12:30 INFO - 'SHLVL': '1', 16:12:30 INFO - 'TERM': 'linux', 16:12:30 INFO - 'TMOUT': '86400', 16:12:30 INFO - 'USER': 'cltbld', 16:12:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', 16:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:30 INFO - '_': '/tools/buildbot/bin/python'} 16:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:12:30 INFO - Cleaning up... 16:12:30 INFO - Return code: 0 16:12:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:12:30 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')]} 16:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:30 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')]} 16:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:30 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1358eb0>, '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 0x1359db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135a240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', '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 16:12:30 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 16:12:30 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 16:12:30 INFO - Using env: {'DISPLAY': ':0', 16:12:30 INFO - 'HOME': '/home/cltbld', 16:12:30 INFO - 'LANG': 'en_US.UTF-8', 16:12:30 INFO - 'LANGUAGE': 'en_US:en', 16:12:30 INFO - 'LOGNAME': 'cltbld', 16:12:30 INFO - 'MAIL': '/var/mail/cltbld', 16:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:30 INFO - 'MOZ_NO_REMOTE': '1', 16:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:30 INFO - 'NO_EM_RESTART': '1', 16:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:30 INFO - 'PWD': '/builds/slave/test', 16:12:30 INFO - 'SHELL': '/bin/bash', 16:12:30 INFO - 'SHLVL': '1', 16:12:30 INFO - 'TERM': 'linux', 16:12:30 INFO - 'TMOUT': '86400', 16:12:30 INFO - 'USER': 'cltbld', 16:12:30 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', 16:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:30 INFO - '_': '/tools/buildbot/bin/python'} 16:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:30 INFO - Downloading/unpacking blobuploader==1.2.4 16:12:30 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 16:12:30 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 16:12:30 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 16:12:30 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 16:12:31 INFO - Downloading blobuploader-1.2.4.tar.gz 16:12:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:12:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:12:31 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 16:12:31 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 16:12:31 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 16:12:31 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 16:12:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:12:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:12:32 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 16:12:32 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 16:12:32 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 16:12:32 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 16:12:32 INFO - Downloading docopt-0.6.1.tar.gz 16:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:12:32 INFO - Installing collected packages: blobuploader, requests, docopt 16:12:32 INFO - Running setup.py install for blobuploader 16:12:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:12:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:12:32 INFO - Running setup.py install for requests 16:12:32 INFO - Running setup.py install for docopt 16:12:32 INFO - Successfully installed blobuploader requests docopt 16:12:32 INFO - Cleaning up... 16:12:32 INFO - Return code: 0 16:12:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:32 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1358eb0>, '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 0x1359db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135a240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', '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 16:12:32 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 16:12:32 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 16:12:32 INFO - Using env: {'DISPLAY': ':0', 16:12:32 INFO - 'HOME': '/home/cltbld', 16:12:32 INFO - 'LANG': 'en_US.UTF-8', 16:12:32 INFO - 'LANGUAGE': 'en_US:en', 16:12:32 INFO - 'LOGNAME': 'cltbld', 16:12:32 INFO - 'MAIL': '/var/mail/cltbld', 16:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:32 INFO - 'MOZ_NO_REMOTE': '1', 16:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:32 INFO - 'NO_EM_RESTART': '1', 16:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:32 INFO - 'PWD': '/builds/slave/test', 16:12:32 INFO - 'SHELL': '/bin/bash', 16:12:32 INFO - 'SHLVL': '1', 16:12:32 INFO - 'TERM': 'linux', 16:12:32 INFO - 'TMOUT': '86400', 16:12:32 INFO - 'USER': 'cltbld', 16:12:32 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', 16:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:32 INFO - '_': '/tools/buildbot/bin/python'} 16:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:33 INFO - Running setup.py (path:/tmp/pip-2zmSHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:33 INFO - Running setup.py (path:/tmp/pip-hlbSCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:33 INFO - Running setup.py (path:/tmp/pip-Y5ypZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:33 INFO - Running setup.py (path:/tmp/pip-k0NXT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:33 INFO - Running setup.py (path:/tmp/pip-7SNQhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:33 INFO - Running setup.py (path:/tmp/pip-ROk92V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:33 INFO - Running setup.py (path:/tmp/pip-wqIRYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:33 INFO - Running setup.py (path:/tmp/pip-GbFp4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:33 INFO - Running setup.py (path:/tmp/pip-EQqbd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:33 INFO - Running setup.py (path:/tmp/pip-JNX8nQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:33 INFO - Running setup.py (path:/tmp/pip-geq5WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:33 INFO - Running setup.py (path:/tmp/pip-kxF1bA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:34 INFO - Running setup.py (path:/tmp/pip-rjBOVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:34 INFO - Running setup.py (path:/tmp/pip-rdMCJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:34 INFO - Running setup.py (path:/tmp/pip-TC1gHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:34 INFO - Running setup.py (path:/tmp/pip-qsvpId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:34 INFO - Running setup.py (path:/tmp/pip-3DjS0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:12:34 INFO - Running setup.py install for manifestparser 16:12:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:12:34 INFO - Running setup.py install for mozcrash 16:12:34 INFO - Running setup.py install for mozdebug 16:12:34 INFO - Running setup.py install for mozdevice 16:12:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:12:34 INFO - Running setup.py install for mozfile 16:12:34 INFO - Running setup.py install for mozhttpd 16:12:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:12:34 INFO - Running setup.py install for mozinfo 16:12:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:12:35 INFO - Running setup.py install for mozInstall 16:12:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:12:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:12:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:12:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:12:35 INFO - Running setup.py install for mozleak 16:12:35 INFO - Running setup.py install for mozlog 16:12:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:12:35 INFO - Running setup.py install for moznetwork 16:12:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:12:35 INFO - Running setup.py install for mozprocess 16:12:35 INFO - Running setup.py install for mozprofile 16:12:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:12:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:12:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:12:35 INFO - Running setup.py install for mozrunner 16:12:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:12:35 INFO - Running setup.py install for mozscreenshot 16:12:35 INFO - Running setup.py install for moztest 16:12:36 INFO - Running setup.py install for mozversion 16:12:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:12:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:12:36 INFO - Cleaning up... 16:12:36 INFO - Return code: 0 16:12:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:36 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1358eb0>, '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 0x1359db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135a240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', '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 16:12:36 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 16:12:36 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 16:12:36 INFO - Using env: {'DISPLAY': ':0', 16:12:36 INFO - 'HOME': '/home/cltbld', 16:12:36 INFO - 'LANG': 'en_US.UTF-8', 16:12:36 INFO - 'LANGUAGE': 'en_US:en', 16:12:36 INFO - 'LOGNAME': 'cltbld', 16:12:36 INFO - 'MAIL': '/var/mail/cltbld', 16:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:36 INFO - 'MOZ_NO_REMOTE': '1', 16:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:36 INFO - 'NO_EM_RESTART': '1', 16:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:36 INFO - 'PWD': '/builds/slave/test', 16:12:36 INFO - 'SHELL': '/bin/bash', 16:12:36 INFO - 'SHLVL': '1', 16:12:36 INFO - 'TERM': 'linux', 16:12:36 INFO - 'TMOUT': '86400', 16:12:36 INFO - 'USER': 'cltbld', 16:12:36 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', 16:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:36 INFO - '_': '/tools/buildbot/bin/python'} 16:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:36 INFO - Running setup.py (path:/tmp/pip-GcDlcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:36 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)) 16:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:36 INFO - Running setup.py (path:/tmp/pip-clk3r2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:36 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)) 16:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:36 INFO - Running setup.py (path:/tmp/pip-Y4MTrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:36 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)) 16:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:36 INFO - Running setup.py (path:/tmp/pip-9aOand-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:36 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)) 16:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:36 INFO - Running setup.py (path:/tmp/pip-itbXYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:36 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)) 16:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:36 INFO - Running setup.py (path:/tmp/pip-jPOkbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:36 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)) 16:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:36 INFO - Running setup.py (path:/tmp/pip-JVpoRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:36 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)) 16:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:36 INFO - Running setup.py (path:/tmp/pip-6_A4WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:36 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)) 16:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:36 INFO - Running setup.py (path:/tmp/pip-ZVuliF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:37 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)) 16:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:37 INFO - Running setup.py (path:/tmp/pip-W5JbD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:37 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)) 16:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:37 INFO - Running setup.py (path:/tmp/pip-iAkIwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:37 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)) 16:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:37 INFO - Running setup.py (path:/tmp/pip-ayNYR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:37 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)) 16:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:37 INFO - Running setup.py (path:/tmp/pip-kKnhJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:37 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)) 16:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:37 INFO - Running setup.py (path:/tmp/pip-ulE4id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:37 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)) 16:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:37 INFO - Running setup.py (path:/tmp/pip-8gdqIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:37 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)) 16:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:37 INFO - Running setup.py (path:/tmp/pip-ve2Pv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:37 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)) 16:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:37 INFO - Running setup.py (path:/tmp/pip-ERUrqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:37 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)) 16:12:37 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)) 16:12:37 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)) 16:12:37 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)) 16:12:37 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)) 16:12:37 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)) 16:12:37 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)) 16:12:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12: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 16:12: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 16:12: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 16:12: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 16:12:38 INFO - Downloading blessings-1.6.tar.gz 16:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:12:38 INFO - Installing collected packages: blessings 16:12:38 INFO - Running setup.py install for blessings 16:12:38 INFO - Successfully installed blessings 16:12:38 INFO - Cleaning up... 16:12:38 INFO - Return code: 0 16:12:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:12:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:39 INFO - Reading from file tmpfile_stdout 16:12:39 INFO - Current package versions: 16:12:39 INFO - argparse == 1.2.1 16:12:39 INFO - blessings == 1.6 16:12:39 INFO - blobuploader == 1.2.4 16:12:39 INFO - docopt == 0.6.1 16:12:39 INFO - functools32 == 3.2.3-2 16:12:39 INFO - jsonschema == 2.5.1 16:12:39 INFO - manifestparser == 1.1 16:12:39 INFO - mozInstall == 1.13 16:12:39 INFO - mozcrash == 1.0 16:12:39 INFO - mozdebug == 0.1 16:12:39 INFO - mozdevice == 0.51 16:12:39 INFO - mozfile == 1.2 16:12:39 INFO - mozhttpd == 0.7 16:12:39 INFO - mozinfo == 0.10 16:12:39 INFO - mozleak == 0.1 16:12:39 INFO - mozlog == 3.5 16:12:39 INFO - moznetwork == 0.27 16:12:39 INFO - mozprocess == 0.25 16:12:39 INFO - mozprofile == 0.28 16:12:39 INFO - mozrunner == 6.13 16:12:39 INFO - mozscreenshot == 0.1 16:12:39 INFO - mozsystemmonitor == 0.3 16:12:39 INFO - moztest == 0.8 16:12:39 INFO - mozversion == 1.4 16:12:39 INFO - psutil == 3.1.1 16:12:39 INFO - requests == 1.2.3 16:12:39 INFO - wsgiref == 0.1.2 16:12:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12: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')]} 16:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:39 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 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1358eb0>, '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 0x1359db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135a240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', '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 16:12:39 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 16:12:39 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 16:12:39 INFO - Using env: {'DISPLAY': ':0', 16:12:39 INFO - 'HOME': '/home/cltbld', 16:12:39 INFO - 'LANG': 'en_US.UTF-8', 16:12:39 INFO - 'LANGUAGE': 'en_US:en', 16:12:39 INFO - 'LOGNAME': 'cltbld', 16:12:39 INFO - 'MAIL': '/var/mail/cltbld', 16:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:39 INFO - 'MOZ_NO_REMOTE': '1', 16:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:39 INFO - 'NO_EM_RESTART': '1', 16:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:39 INFO - 'PWD': '/builds/slave/test', 16:12:39 INFO - 'SHELL': '/bin/bash', 16:12:39 INFO - 'SHLVL': '1', 16:12:39 INFO - 'TERM': 'linux', 16:12:39 INFO - 'TMOUT': '86400', 16:12:39 INFO - 'USER': 'cltbld', 16:12:39 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', 16:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:39 INFO - '_': '/tools/buildbot/bin/python'} 16:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:39 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)) 16:12:39 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)) 16:12:39 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)) 16:12:39 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)) 16:12:39 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)) 16:12:39 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)) 16:12:39 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)) 16:12:39 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)) 16:12:39 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)) 16:12:39 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:12: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 16:12: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 16:12: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 16:12: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 16:12:40 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:12:40 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 16:12:40 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 16:12:40 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 16:12:40 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 16:12:40 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 16:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:12:40 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)) 16:12:40 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)) 16:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:12:40 INFO - Installing collected packages: marionette-driver, simplejson 16:12:40 INFO - Running setup.py install for marionette-driver 16:12:40 INFO - Running setup.py install for simplejson 16:12:40 INFO - building 'simplejson._speedups' extension 16:12:40 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 16:12:41 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 16:12:41 INFO - Successfully installed marionette-driver simplejson 16:12:41 INFO - Cleaning up... 16:12:41 INFO - Return code: 0 16:12:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12: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')]} 16:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11b8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135bd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1358eb0>, '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 0x1359db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135a240>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', '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 16:12: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'] in /builds/slave/test/build 16:12: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 16:12:41 INFO - Using env: {'DISPLAY': ':0', 16:12:41 INFO - 'HOME': '/home/cltbld', 16:12:41 INFO - 'LANG': 'en_US.UTF-8', 16:12:41 INFO - 'LANGUAGE': 'en_US:en', 16:12:41 INFO - 'LOGNAME': 'cltbld', 16:12:41 INFO - 'MAIL': '/var/mail/cltbld', 16:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:41 INFO - 'MOZ_NO_REMOTE': '1', 16:12:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:41 INFO - 'NO_EM_RESTART': '1', 16:12:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:41 INFO - 'PWD': '/builds/slave/test', 16:12:41 INFO - 'SHELL': '/bin/bash', 16:12:41 INFO - 'SHLVL': '1', 16:12:41 INFO - 'TERM': 'linux', 16:12:41 INFO - 'TMOUT': '86400', 16:12:41 INFO - 'USER': 'cltbld', 16:12:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', 16:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:41 INFO - '_': '/tools/buildbot/bin/python'} 16:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:12:42 INFO - Cleaning up... 16:12:42 INFO - Return code: 0 16:12:42 INFO - Running post-action listener: _resource_record_post_action 16:12:42 INFO - Running post-action listener: _start_resource_monitoring 16:12:42 INFO - Starting resource monitoring. 16:12:42 INFO - [mozharness: 2017-07-27 23:12:42.226494Z] Finished create-virtualenv step (success) 16:12:42 INFO - [mozharness: 2017-07-27 23:12:42.227020Z] Running install step. 16:12:42 INFO - Running pre-action listener: _resource_record_pre_action 16:12:42 INFO - Running main action method: install 16:12:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:42 INFO - Reading from file tmpfile_stdout 16:12:42 INFO - Detecting whether we're running mozinstall >=1.0... 16:12:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:12:42 INFO - Reading from file tmpfile_stdout 16:12:42 INFO - Output received: 16:12:42 INFO - Usage: mozinstall [options] installer 16:12:42 INFO - Options: 16:12:42 INFO - -h, --help show this help message and exit 16:12:42 INFO - -d DEST, --destination=DEST 16:12:42 INFO - Directory to install application into. [default: 16:12:42 INFO - "/builds/slave/test"] 16:12:42 INFO - --app=APP Application being installed. [default: firefox] 16:12:42 INFO - mkdir: /builds/slave/test/build/application 16:12:42 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'] 16:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:13:01 INFO - Reading from file tmpfile_stdout 16:13:01 INFO - Output received: 16:13:01 INFO - /builds/slave/test/build/application/firefox/firefox 16:13:01 INFO - Running post-action listener: _resource_record_post_action 16:13:01 INFO - [mozharness: 2017-07-27 23:13:01.112364Z] Finished install step (success) 16:13:01 INFO - [mozharness: 2017-07-27 23:13:01.112619Z] Running setup-mitmproxy step. 16:13:01 INFO - Running pre-action listener: _resource_record_pre_action 16:13:01 INFO - Running main action method: setup_mitmproxy 16:13:01 INFO - Skipping: mitmproxy is not required 16:13:01 INFO - Running post-action listener: _resource_record_post_action 16:13:01 INFO - [mozharness: 2017-07-27 23:13:01.113856Z] Finished setup-mitmproxy step (success) 16:13:01 INFO - [mozharness: 2017-07-27 23:13:01.114082Z] Running run-tests step. 16:13:01 INFO - Running pre-action listener: _resource_record_pre_action 16:13:01 INFO - Running pre-action listener: _set_gcov_prefix 16:13:01 INFO - Running main action method: run_tests 16:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:13:01 INFO - Python 2.7.3 16:13:01 INFO - Return code: 0 16:13:01 INFO - grabbing minidump binary from tooltool 16:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:01 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 0x1358eb0>, '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 0x1359db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x135a240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:13:01 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 16:13:01 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 16:13:01 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 16:13:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:13:01 INFO - Return code: 0 16:13:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:13:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:13:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:13:01 INFO - ENV: RUST_BACKTRACE is now 1 16:13:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:13:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 16:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 16:13:01 INFO - Using env: {'DISPLAY': ':0', 16:13:01 INFO - 'HOME': '/home/cltbld', 16:13:01 INFO - 'LANG': 'en_US.UTF-8', 16:13:01 INFO - 'LANGUAGE': 'en_US:en', 16:13:01 INFO - 'LOGNAME': 'cltbld', 16:13:01 INFO - 'MAIL': '/var/mail/cltbld', 16:13:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:13:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:01 INFO - 'MOZ_NO_REMOTE': '1', 16:13:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:01 INFO - 'NO_EM_RESTART': '1', 16:13:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:01 INFO - 'PWD': '/builds/slave/test', 16:13:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:13:01 INFO - 'RUST_BACKTRACE': '1', 16:13:01 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:13:01 INFO - 'SHELL': '/bin/bash', 16:13:01 INFO - 'SHLVL': '1', 16:13:01 INFO - 'TERM': 'linux', 16:13:01 INFO - 'TMOUT': '86400', 16:13:01 INFO - 'USER': 'cltbld', 16:13:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342', 16:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:01 INFO - '_': '/tools/buildbot/bin/python'} 16:13:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 16:13:01 INFO - mozversion application_buildid: 20170727222513 16:13:01 INFO - mozversion application_changeset: 0379882c11f6d72f11d265036fc815e73b9ef5b2 16:13:01 INFO - mozversion application_display_name: Nightly 16:13:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:13:01 INFO - mozversion application_name: Firefox 16:13:01 INFO - mozversion application_remotingname: firefox 16:13:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:13:01 INFO - mozversion application_vendor: Mozilla 16:13:01 INFO - mozversion application_version: 56.0a1 16:13:01 INFO - mozversion platform_buildid: 20170727222513 16:13:01 INFO - mozversion platform_changeset: 0379882c11f6d72f11d265036fc815e73b9ef5b2 16:13:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:13:01 INFO - mozversion platform_version: 56.0a1 16:13:01 INFO - using testdate: 1501197181 16:13:01 INFO - actual date: 1501197181 16:13:01 INFO - starting webserver on 'localhost:44935' 16:13:01 INFO - SUITE-START | Running 2 tests 16:13:01 INFO - TEST-START | dromaeo_css 16:13:01 INFO - Initialising browser for dromaeo_css test... 16:13:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44935/getInfo.html -profile /tmp/tmpCJkAk6/profile 16:13:01 INFO - TEST-INFO | started process 12280 (/builds/slave/test/build/application/firefox/firefox http://localhost:44935/getInfo.html) 16:13:06 INFO - TEST-INFO | 12280: exit 0 16:13:06 INFO - Browser initialized. 16:13:06 INFO - Running cycle 1/1 for dromaeo_css test... 16:13:06 INFO - TEST-INFO | started process 12490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCJkAk6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:07 INFO - PID 12490 | 16:13:07 INFO - PID 12490 | (/builds/slave/test/build/application/firefox/firefox:12538): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:13:07 INFO - PID 12490 | 16:13:18 INFO - PID 12490 | RSS: Main: 171241472 16:13:18 INFO - PID 12490 | 16:16:17 INFO - PID 12490 | Cycle 1(1): loaded http://localhost:44935/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44935/tests/dromaeo/cssquery-ext.html) 16:16:18 INFO - PID 12490 | RSS: Main: 173305856 16:16:18 INFO - PID 12490 | 16:19:20 INFO - PID 12490 | Cycle 1(1): loaded http://localhost:44935/tests/dromaeo/cssquery-ext.html (next: http://localhost:44935/tests/dromaeo/cssquery-jquery.html) 16:19:21 INFO - PID 12490 | RSS: Main: 171249664 16:19:21 INFO - PID 12490 | 16:22:22 INFO - PID 12490 | Cycle 1(1): loaded http://localhost:44935/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44935/tests/dromaeo/cssquery-mootools.html) 16:22:23 INFO - PID 12490 | RSS: Main: 172609536 16:22:23 INFO - PID 12490 | 16:25:25 INFO - PID 12490 | Cycle 1(1): loaded http://localhost:44935/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44935/tests/dromaeo/cssquery-prototype.html) 16:25:25 INFO - PID 12490 | RSS: Main: 171544576 16:25:25 INFO - PID 12490 | 16:28:29 INFO - PID 12490 | Cycle 1(1): loaded http://localhost:44935/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44935/tests/dromaeo/cssquery-yui.html) 16:28:30 INFO - PID 12490 | RSS: Main: 172793856 16:28:30 INFO - PID 12490 | 16:31:32 INFO - PID 12490 | Cycle 1(1): loaded http://localhost:44935/tests/dromaeo/cssquery-yui.html (next: http://localhost:44935/tests/dromaeo/cssquery-dojo.html) 16:31:32 INFO - PID 12490 | RSS: Main: 175308800 16:31:32 INFO - PID 12490 | 16:31:32 INFO - PID 12490 | __start_tp_report 16:31:32 INFO - PID 12490 | _x_x_mozilla_page_load 16:31:32 INFO - PID 12490 | _x_x_mozilla_page_load_details 16:31:32 INFO - PID 12490 | |i|pagename|runs| 16:31:32 INFO - PID 12490 | |0;dojo.html;3118.7193152616246;3161.588993430854;3167.6832316768314;3185.3151572411925;3209.1335339458346;6053.727582258798;6118.908216376758;6193.969030154849;6194.163787888634;6228.22147231596;6218.62688238706;6253.687315634212;6305.369463053692;6321.7155228014735;6329;5650.434956504358;5682.374938756733;5757.539396848242;5796.82609521715;5856.385079566648;5578.30271216098;5596.804111856086;5662.773489060432;5707.914381284284;5723.799667011655;5654.462826031541;5724.398938111522;5731.025725626632;5739.1965124882345;5746.339170995348;5623.409541998072;5641.802536911188;5713.114467257582;5718.1136923776885;5744.827655170351;5544.944550554484;5615.438456154393;5660.094384898438;5676.772929082832;5678.858028549278;6001.789937352215;6030.577859549833;6054.091886217058;6059.878802423971;6069.423404776539;6666;6666.566673166277;6671.432928201109;6672.099266598995;6677.3656502632175;6726.93273067268;6740.460763138937;6741.056252124707;6742.056112144303;6742.966285168592;6151.446369826737;6199.442050215503;6203.410675985729;6238.750449981995;6242.6878656067465;6886.896696549556;6887.380135787803;6888.862222755517;6918.757843475454;6922.930770692329;6511;6521.869562608721;6596.274409814917;6601.900971485432;6616.172978377703;6523.510736694767;6592.17597800275;6603.405693487609;6692.464602831762;6705.865882682319;6573.769918052941;6596;6673.232578253563;6678.7662431815625;6686.933130668631;6732.427743641747;6738.831529211809;6740.359665831738;6753.831154221184;6784.728610855511;5321.095413779667;5329.173978033411;5407.161889907071;5421.403645598981;5424.538914192338;4572.908541829145;4574.290984897346;4633.513481084505;4642.3500709900645;4666.393368862026;5766.625169363978;5833.095870140135;5835.649861008353;5852.502537284294;5854.502367298827;6696.966515167393;6699.665016749143;6709.027191057269;6719.294474080249;6727.125473688389;5766.855828604234;5775;5821.126830975388;5860.501857342174;5891.3814049525035;5870.119482077637;5901.911471327933;5907.940920590825;5963.970180149158;5983.760649573968;6368.713407896656;6467;6479.773207937794;6480.773172939019;6573.408393244631;6609.405153536205;6615.239247486601;6624.105745724266;6708.262091170065;6712.798616041527;6574.737010519526;6581.703823327866;6587.769428069994;6602.438792702674;6606.570572912745;6576.408123268929;6612.900806488003;6685;6687;6697.9953007049335;6660.966695166493;6731.124953755981;6738.561993470409;6840.48696347766;6853.109095817512;6452.645104519296;6471.320511346429;6487.18910136233;6544.509161812978;6547.214334279917;6448.387403196689;6457.192850893638;6465.353464653497;6547.214334279917;6555.836104097245;6379.202599675041;6391.520635952415;6484.416402523795;6490.545661803629;6494.090827284279;6428.77853207889;6440.4525615321345;6589.835254118685;6590.373914478117;6621.702023408862;6288.748450061947;6290.2766181889665;6328.114064030948;6341.365863413622;6373.235211774617 16:31:32 INFO - PID 12490 | |1;ext.html;807.6123460738845;835.2482765511041;869.791250099976;877.4866702978757;1185.3480585677885;30395.39209215817;30855.228619284502;31003.84498077509;41260.381094283606;41504.37743433851;41686.7915660422;42223;42258.154836903246;42329.365059524134;42390.36414453786;7423.369013633847;7857.567833769154;8017.078036025844;8105.675772969074;8108.959455202716;7882.093559240703;7951.40364472664;7963.044434667848;8004.51972881629;8016.278534931855;7979;8034;8038.397120215978;8042.798930026737;8049;7878.881816772753;7900.7629771106385;7923.801904952394;7951.16512766157;7967.16344783798;7787.221277872168;7860.410469214775;7863.213678632091;7868.173841746591;7894.4079194060105;38093.61906380928;38342.61657383418;38358.80820595879;38373;38400.61599383999;3545.06055895188;3584.910377240564;3588.5873124590744;3589.2821435712963;3595.928081438383;30780;31013.534796978063;31143.221419464695;31175.220619484466;31368.529472057937;4844.539768721966;4849.660523763338;4885.413750349945;4889.902201955941;4934.728589927553;181629;182694;182986;184068.0796596022;184358;47830.5216947833;47920.76039619849;47957;47963;48182.75908620434;50451.24323135156;50511.49488505141;50548.24177637338;50694;50801.237981430306;16266.18669066542;16518.917405412896;16573.08848013347;16591.751123733153;16624.168791560372;12153.210041347284;12334.074944379028;12349.135560510678;12352.320622365676;13660.795088073686;13688.863111368959;13722;13812.309384530734;14064.226467544384;14092.224927629079;5397.3523177218985;5498.367687715964;5549.556035517149;5561.499465048165;5589.580781441408;977.5600979559226;981.7545613596601;1006.2704539209014;1021.7292417509366;1022.3610243597751;21901.890490547445;22332.665010024863;22332.88833555822;23169.768302316763;23194.3041708749;1082.3343643659093;1110.711215084084;1115.3085087245959;1119.6641007697822;1136.2557524821254;11570.826437603442;12196.39018049094;12292.877071229352;12347.567835125728;12466.376681165906;224698;226233;226312;226477;226897;58045.70977145087;58941.70529147327;58948.41051589429;59196;59197.70401148053;1490.1357212816756;1493.2235237676348;1499.9850001500063;1510.7582786754067;1523.5581681312517;27020.32449188786;27706.584401233595;27995.300117497227;28097;28100.297492562033;37978.81010594929;50986;51393.229101562756;51677;51721.22418163655;198129;198341;199036;199205;200208;30516.185476815397;31464;32077.35845283128;35749.28501430009;35937.46093808542;40623.59376406198;46491.53508464872;46873.76563117163;46908.29637555371;47066;31029.0691279262;32125;32132.83933580317;32225.51661725123;32244.35511289808;29772.80908763625;30311.545326819672;30850.845745771127;31312.843435782674;31353.686463135076;35891.64108358883;36027.27945441129;36296;36307.63692363042;36322.8183859079;29619.407611848073;30620.387592248477;31068.378632427677;31425.371492570477;31578;21622.486425950032;23334.88332558394;23724.406889827893;23830.404239894142;23859.880700596386 16:31:32 INFO - PID 12490 | |2;jquery.html;573.8249833800689;580.9796657117001;584.862557299035;588.8704485013297;601.4166258729033;22161;22936.311910642686;22942.426439339026;22951.885240573814;23054;24030.75969240307;25140.874295628495;26235.3441163971;26333.47333053338;26360;6580.835479113012;6746.426553742937;6749.493787965897;6755.054292399068;6757.864842703143;6339.587926784768;6666.500012499057;6727.192736871582;6733.629650369227;6928.792136235921;6918.8962165567555;6934.68793904273;6941.305869413043;6943.72225110995;6944.409725173341;6893.896591551131;6914.792556223296;6916.23921368649;6920;6923.238443771181;6763.256041835394;6775.932240677579;6791.626460544668;6802;6805.387515123613;29859.70140298591;31670.366592668248;31751.364972700416;31764.04707858768;32203.838980804947;1911.5603411215359;1953.169902791308;1953.658109830774;1957.7944315846917;1959.980400195994;19510.414687559394;20056.899715501477;20088.09603567843;20144.19423223084;20157.899210504;2491.6636254105824;2496.5506208882393;2570.9357266068496;2570.948581028369;2574.0604679291923;128725;131101;131104;131503;131655.34172329077;19849.503762406057;21897;21898.562028759334;21922.355823313315;22619.43451413728;43627.781861090494;43668.78165609215;43747.56252437435;43764.562354376685;43768.78115609402;11206.38364889939;11218.943905280421;11291.774164516664;11440.199186056896;11472.991827785596;9159.450432974043;9261.398009129385;9405.623775049058;9464.668736594185;9523.095305945924;8821.750453634282;9468.857967130498;9505.239580833517;11478.655640330804;11482.770344593062;2632.447186090904;2700.189943017087;2700.6901652698425;2754.9586756198673;2796.9021084261954;926.1340646495548;945.9621615135318;949.0604301741364;970.1801977329145;980.789130336981;18734.531636708918;19000.619987600447;19039.904800476186;19314.903425482782;19637.018149092488;990.9009099090033;1016.4866742295094;1020.9591616335264;1025.9538320775582;1040.9479526023667;10287.43419111956;10602.734931626772;10632.574697012187;10756.08573271265;11010.39442830636;491735;507309;508486;509020;509923;113696.43151784354;114773;116237;117683.99999999828;119956;1183.431952662718;1217.5008246618843;1238.9256644601173;1246.1899765152723;1255.0649765924445;16412.17939103064;17226;17523.649527009642;17661.470155895342;17729.645407091528;53157.20264195963;53506.73246633742;53768.462315376346;55147.72426137843;55861;70785.29214707993;71497;71599;71663;71931.64034179796;12513.93743031279;13137.080404371985;14770.409183632964;15035.774463382839;15134.697306054037;23173.768262317837;24034;24072.398190045387;24326.87836560806;24673.38316542029;18850.811491884906;19064.04679766034;19111.617767644846;19224.903875480533;19322.61354772925;16824.57938551546;17121.76176018292;17150.828491714925;17561.209745561224;17684.64630707353;18628.441146765617;19206.7118993218;19246.037698115317;19705.901470492558;19757.802421975597;14429.855701442852;14496;14737.926310368379;14743.18912459825;14784.260786960394;18942.715859262396;18954.241830327184;19001.524961876064;19005.429837104908;19164.425067248005 16:31:32 INFO - PID 12490 | |3;mootools.html;1336.6457888659504;1374.237298299444;1405.5431984605;1410.1327683474667;1418.3830033935233;11758.941205293972;12283.14018018739;13364.997625178114;13766.518171863987;13776.58670239892;13469.124506907045;13554.93222533886;13561.864381356208;13580;13615.727685446285;2401.591729406005;2541.606051062088;2594.429225570381;2595.6885173779174;2598.44133511295;2654.0843409023855;2675.973240267602;2676.8661566921674;2677.799165062628;2681.12863319421;2551.872406379683;2555.2078855554746;2564.384547708546;2570.678665166854;2576.1756238003845;2429.5019520998153;2433.963490547634;2470.8270421070533;2516.3331717094984;2538.5430622487943;2476.987615061931;2511.7739403453775;2560.8207425480223;2566.1531694540945;2571.459993401388;13763.931180344034;13774.517891873737;13856.515021974183;13888.791668124986;13924.234167120805;7547.584882831442;7824.452288339761;7824.882626760603;7826.882596761053;7894.64474098667;4591.724496530219;4811.422629284508;4917.532834380728;4918.311436398907;4920.606351491872;1793.0944872839264;1823.79026411963;1840.7791065072142;1878.7651543557056;1883;21889.233876814393;21972.450688732908;22013.339599812032;22075.889620551956;22122.778772212394;6451.677416129175;7026.613536255452;7090.704097759402;7292.489525733148;7294.96352518234;14734.852651473562;14881.33034013472;14917.70164596702;14923.477678281208;14927.701445971237;7381.077365329334;7486;7516.135644400964;7531.548107113591;7534.54792712439;6806.55757375769;6976.407005404496;7057.294270573005;7135.536190147727;7139.178994415604;5037.848864533997;5083.186690129635;5094.2613321068975;5136.409312928986;5160.251763494272;1507.9396824127132;1521.634807646157;1545.652228248635;1552.9378824847106;1560.4694403902727;804.899387576553;813.1705660226536;824.7154731617583;844.7507985144397;865.0441262404952;6455.838604034937;6736.93263067363;6752.898706519406;7727.961360193163;7976.800579985546;914.6478605736839;936.7096200177966;974.468914441631;990.5542505872386;991.4893829677721;4367.47590289161;4653.790579423934;4775.997040621439;4787.569118779257;4870.95129048705;18175.81824181741;18432.170552325177;18721.344752933855;18722.251109955723;18748.906255468908;18087.72868406975;18216.08919554017;18721;18757.249710011718;18758.437246882342;10705;10844.349339039525;10848.077913377452;10887.237893347548;10926.945365273281;6857.177138743184;7209.671026555605;7348.706051758084;7423.628818559158;7521.7743467696055;15993.600159995627;16410.425635102714;16488.752668710218;16492;16528.25622846999;15989.200539973188;16483.175841208133;16483.505494835175;16518.587035323733;16797.41209057726;10061.89938100639;10286.948565257126;10619.36283822973;11115.944420277847;11227.607033753779;12422.440990155284;12528.624141275777;12554.372281386077;12576.119671622899;12595.118341715992;9393.577289022147;9846.704598862045;9971.45157016371;10081.294309398272;10333.896661033594;9230.723078307661;9489.952550237205;9531.857022144535;9583.808323833346;9613.471259080818;8369.330453563822;8437.873431898404;8466.872996905175;8492.490450572985;8515.787105322417;6395.20059992501;6446.387593178641;6613.041109039066;6615.735370585123;6637.568558043712;6103.725332359965;6164.445199932027;6219.378062193744;6223.101953904103;6299.433051025429 16:31:32 INFO - PID 12490 | |4;prototype.html;488.7922632881027;500.1447524732708;517.6609320894814;524.2869697211792;525.8536390668346;6113.755449782004;6203.441690247877;6220.098085777565;6301.1808464899495;6353.682315884204;5978.312494063184;6046.183765191698;6065.302490213627;6108.755649774003;6156.507479401648;4859.659823812326;4949.208126699728;4964.156093464102;4966.404031516205;4969.801207951696;4826.131296366652;4913.361263035818;4916.50834916509;4951.504849515056;4954.504549545035;4823.589994850425;4910.140725373063;4937.753112344386;4938.38270216223;4957.529034741712;4810.927836082462;4912.533309335608;4945.134601444751;4975.5322179957;4977.42759582649;4401.955980440187;4441.888952776174;4450.933236001462;4495.370648109268;4507.864764057083;6015.669138197398;6040;6047.518358002274;6066.181065556182;6068.969655151696;5659.886802263932;5669.149627555858;5679.375268720438;5697.857553561194;5729.541636669056;6314.526410519229;6333.651649159295;6433.163688720483;6465.3857883501;6465.935340646627;4853.3690620219495;4861.756912154378;4871.926921096187;4899.559039686445;4917.114919314522;6778.694958726771;6851.760188393432;6865.382115609619;6899.655017249168;6940.618265995368;4941.6293777966075;4997.675151115166;5018.548330650259;5023.874403139877;5029.924551131736;5056.84829455117;5083.694978301313;5095.184770436712;5097.566706829887;5114.744262786846;5619.80330688424;5643.266375371258;5649.915251271234;5706.4864162225595;5739.913901291484;6503.349665033459;6534.379233972765;6553.246376666649;6559.704813283413;6604.900926486107;1688.3499852556608;1717.7681013063327;1717.7938647362396;1726.9740953885703;1768.5578605348662;1184.8518935133109;1218.524775337619;1220.9328486933305;1230.4155526125019;1233.747081848219;5668.348139963874;5682.374938756733;5694.209837179752;5694.914576281359;5697.743601537941;6440.516961227927;6475.384838440341;6504.479641628658;6527.3472652734345;6553.279139294674;5704.401037890962;5709.314882214161;5734.971325143348;5785.82642520725;5801.158831969426;3531.805750683686;3540.6105328413855;3548.556430446194;3548.722459914429;3566.4828599853395;6457.096006559085;6530.412262896362;6552.14822073137;6584.703688334036;6598.8350291243105;6875.965620171867;6928.688209030605;6933.168019837551;6956.165260168812;7000.089988301488;6243.314305137678;6396.648184349812;6467.256265529524;6524.314946930599;6532.510061745388;6623.900641490285;6638.668066596748;6649.168853893263;6698.39714425704;6756.702721074858;6453.1610890583925;6642.535022548375;6747.628880411625;6748.662566871735;6757.547127367639;6513.706883190173;6547.738090476328;6594.439472644879;6604.669766511559;6624.238212605612;4948.505149485023;5006.549410552922;5033.320501732219;5039.596832253337;5042.29407882904;6696.7656132035145;6722.453835617737;6735.440532597778;6763.6618169092335;6792.694328755119;6462.127612772216;6524.739010439529;6540.803775886731;6574.309697481695;6596.90104648421;6479.708413121327;6493.448056915215;6502.187226596676;6577.6053436793945;6623.768168114093;6193.163922870355;6210.968945155245;6398.824399704123;6401.927075003931;6427.55007149495;6477.574933514619;6484.740610375721;6490.545661803817;6545.607263564201;6579.901301480578;6164.568480206342;6180.752769889334;6215.658138802229;6302.117703521602;6346.415154663866 16:31:32 INFO - PID 12490 | |5;yui.html;893.1068931068932;899.4108858697554;922.2022950148124;926.0322962504184;926.9490178040205;16673.41643042494;17749.7337539937;18525.166367513462;18568.16443260053;18592.163352649146;16058.357665693358;16074.59813504663;16543.42098026569;20366.389008329774;20651;1013.5742987945063;1045.0646671229244;1049.1868801678684;1049.8477720730489;1050.6060227414719;1023.5956797065155;1046.8272734998754;1048.8584041154422;1050.033968748753;1062.5165549674919;1113.3987646670787;1114.9944250278777;1116.4083035990939;1116.743149075713;1118.552578968415;1100.350793032115;1100.5817789240039;1101.0860985382114;1103.448275862069;1104.2987702808734;809.0332053196432;811.6631597886928;811.7118422959824;812.0093485947135;815.5066184958133;18066.36767713124;18245.63508729818;18900.243990240375;19046.809531904782;19177.712334314998;20107.195712171495;20178.394648160433;20688.793112068837;20691.06890189945;20714.067866946025;15794.842051579451;15926.283317250636;15974.041557506587;15995.280212390471;16236.918815405965;3557.964420355789;3576.695980841632;3590.7306951978444;3591.5510561179854;3592.7305452091196;112262;115500.42249788698;117386;121057.39471302675;124207;16175.919120404322;16540.09029503365;16570.917145414194;16586.917065414596;16599.087050212114;27194.456110877672;29166;29203.56194657082;29290;29471.557926631118;8730.476171429607;8790.912090879137;8811.295096392274;8824.911750882537;8827.029026807046;4094.549599544048;4176.979115104405;4195.8741237762915;4207.684423668237;4255.3829694694095;4975.552200301918;5001.599872010231;5072.340595722606;5097.311862898536;5110.540051395318;946.8248374050685;992.5384696116196;997.1175509673991;1001.9549120289604;1004.0762498501397;639.5427269502328;656.4125108028288;662.7382184037278;684.7055766020559;684.7842929477199;11221.382823944761;12914.289714065628;13185.60443186706;13410.597682069554;13743.312834358243;628.8585068359582;664.9434798042124;667.5827607745159;669.2872091222929;678.8404724889647;5189.351331083614;5342.305500285016;5441.709483411008;5464.836054918359;6265.624062556261;102428;102472.48763756282;103525;104196;105192;86168.13831861726;90397.09602903886;91392;91463;93199;75731.62134189405;77236.61381693055;78627.60686196532;79140.60429697814;79747.60126199448;11806.1821714025;12072.879271207175;12586.622401327975;12746.617601471971;12854.614361569167;34067.65932340645;36516.634833651326;36909.630903691694;37111;37277.81361093177;63548.364516354246;67710.63982925883;67860.3213967854;67880;69130.30869691238;16189.381061893717;16284;16323.918380408022;16428.42500512476;16471;18530.536736581154;19338.4198474046;19581.60836783228;20331.59336813285;20872.165113395902;17103.657926841144;17565.648687025932;17850.732239016164;18757.531061723566;18974.905125474284;17482.125893705517;17547.824521754617;18299.72550411718;18337.266509339475;19062.237510499424;16863.325466981183;17150.656986860442;17999.280028799225;18146.364877229233;18256.08719564043;10945.507452164513;11407.087433005505;11593.362365070003;11761.88238117608;11871.703207419883;13228.669283267995;13328.200307981164;13367.598972030855;13905.446557835112;14098.36557354901 16:31:32 INFO - PID 12490 | __end_tp_report 16:31:32 INFO - PID 12490 | __start_cc_report 16:31:32 INFO - PID 12490 | _x_x_mozilla_cycle_collect,376 16:31:32 INFO - PID 12490 | __end_cc_report 16:31:32 INFO - PID 12490 | __startTimestamp1501198292410__endTimestamp 16:31:32 INFO - PID 12490 | 16:31:32 INFO - PID 12490 | ------- Summary: start ------- 16:31:32 INFO - PID 12490 | Number of tests: 6 16:31:32 INFO - PID 12490 | 16:31:32 INFO - PID 12490 | [#0] dojo.html Cycles:165 Average:6149.26 Median:6391.52 stddev:729.44 (11.4%) stddev-sans-first:691.85 16:31:32 INFO - PID 12490 | Values: 3118.7 3161.6 3167.7 3185.3 3209.1 6053.7 6118.9 6194.0 6194.2 6228.2 6218.6 6253.7 6305.4 6321.7 6329.0 5650.4 5682.4 5757.5 5796.8 5856.4 5578.3 5596.8 5662.8 5707.9 5723.8 5654.5 5724.4 5731.0 5739.2 5746.3 5623.4 5641.8 5713.1 5718.1 5744.8 5544.9 5615.4 5660.1 5676.8 5678.9 6001.8 6030.6 6054.1 6059.9 6069.4 6666.0 6666.6 6671.4 6672.1 6677.4 6726.9 6740.5 6741.1 6742.1 6743.0 6151.4 6199.4 6203.4 6238.8 6242.7 6886.9 6887.4 6888.9 6918.8 6922.9 6511.0 6521.9 6596.3 6601.9 6616.2 6523.5 6592.2 6603.4 6692.5 6705.9 6573.8 6596.0 6673.2 6678.8 6686.9 6732.4 6738.8 6740.4 6753.8 6784.7 5321.1 5329.2 5407.2 5421.4 5424.5 4572.9 4574.3 4633.5 4642.4 4666.4 5766.6 5833.1 5835.6 5852.5 5854.5 6697.0 6699.7 6709.0 6719.3 6727.1 5766.9 5775.0 5821.1 5860.5 5891.4 5870.1 5901.9 5907.9 5964.0 5983.8 6368.7 6467.0 6479.8 6480.8 6573.4 6609.4 6615.2 6624.1 6708.3 6712.8 6574.7 6581.7 6587.8 6602.4 6606.6 6576.4 6612.9 6685.0 6687.0 6698.0 6661.0 6731.1 6738.6 6840.5 6853.1 6452.6 6471.3 6487.2 6544.5 6547.2 6448.4 6457.2 6465.4 6547.2 6555.8 6379.2 6391.5 6484.4 6490.5 6494.1 6428.8 6440.5 6589.8 6590.4 6621.7 6288.7 6290.3 6328.1 6341.4 6373.2 16:31:32 INFO - PID 12490 | 16:31:32 INFO - PID 12490 | [#1] ext.html Cycles:180 Average:37679.09 Median:19647.17 stddev:52788.26 (268.7%) stddev-sans-first:52863.74 16:31:32 INFO - PID 12490 | Values: 807.6 835.2 869.8 877.5 1185.3 30395.4 30855.2 31003.8 41260.4 41504.4 41686.8 42223.0 42258.2 42329.4 42390.4 7423.4 7857.6 8017.1 8105.7 8109.0 7882.1 7951.4 7963.0 8004.5 8016.3 7979.0 8034.0 8038.4 8042.8 8049.0 7878.9 7900.8 7923.8 7951.2 7967.2 7787.2 7860.4 7863.2 7868.2 7894.4 38093.6 38342.6 38358.8 38373.0 38400.6 3545.1 3584.9 3588.6 3589.3 3595.9 30780.0 31013.5 31143.2 31175.2 31368.5 4844.5 4849.7 4885.4 4889.9 4934.7 181629.0 182694.0 182986.0 184068.1 184358.0 47830.5 47920.8 47957.0 47963.0 48182.8 50451.2 50511.5 50548.2 50694.0 50801.2 16266.2 16518.9 16573.1 16591.8 16624.2 12153.2 12334.1 12349.1 12352.3 13660.8 13688.9 13722.0 13812.3 14064.2 14092.2 5397.4 5498.4 5549.6 5561.5 5589.6 977.6 981.8 1006.3 1021.7 1022.4 21901.9 22332.7 22332.9 23169.8 23194.3 1082.3 1110.7 1115.3 1119.7 1136.3 11570.8 12196.4 12292.9 12347.6 12466.4 224698.0 226233.0 226312.0 226477.0 226897.0 58045.7 58941.7 58948.4 59196.0 59197.7 1490.1 1493.2 1500.0 1510.8 1523.6 27020.3 27706.6 27995.3 28097.0 28100.3 37978.8 50986.0 51393.2 51677.0 51721.2 198129.0 198341.0 199036.0 199205.0 200208.0 30516.2 31464.0 32077.4 35749.3 35937.5 40623.6 46491.5 46873.8 46908.3 47066.0 31029.1 32125.0 32132.8 32225.5 32244.4 29772.8 30311.5 30850.8 31312.8 31353.7 35891.6 36027.3 36296.0 36307.6 36322.8 29619.4 30620.4 31068.4 31425.4 31578.0 21622.5 23334.9 23724.4 23830.4 23859.9 16:31:32 INFO - PID 12490 | 16:31:32 INFO - PID 12490 | [#2] jquery.html Cycles:180 Average:35946.92 Median:23113.88 stddev:84610.17 (366.1%) stddev-sans-first:84805.84 16:31:32 INFO - PID 12490 | Values: 573.8 581.0 584.9 588.9 601.4 22161.0 22936.3 22942.4 22951.9 23054.0 24030.8 25140.9 26235.3 26333.5 26360.0 6580.8 6746.4 6749.5 6755.1 6757.9 6339.6 6666.5 6727.2 6733.6 6928.8 6918.9 6934.7 6941.3 6943.7 6944.4 6893.9 6914.8 6916.2 6920.0 6923.2 6763.3 6775.9 6791.6 6802.0 6805.4 29859.7 31670.4 31751.4 31764.0 32203.8 1911.6 1953.2 1953.7 1957.8 1960.0 19510.4 20056.9 20088.1 20144.2 20157.9 2491.7 2496.6 2570.9 2570.9 2574.1 128725.0 131101.0 131104.0 131503.0 131655.3 19849.5 21897.0 21898.6 21922.4 22619.4 43627.8 43668.8 43747.6 43764.6 43768.8 11206.4 11218.9 11291.8 11440.2 11473.0 9159.5 9261.4 9405.6 9464.7 9523.1 8821.8 9468.9 9505.2 11478.7 11482.8 2632.4 2700.2 2700.7 2755.0 2796.9 926.1 946.0 949.1 970.2 980.8 18734.5 19000.6 19039.9 19314.9 19637.0 990.9 1016.5 1021.0 1026.0 1040.9 10287.4 10602.7 10632.6 10756.1 11010.4 491735.0 507309.0 508486.0 509020.0 509923.0 113696.4 114773.0 116237.0 117684.0 119956.0 1183.4 1217.5 1238.9 1246.2 1255.1 16412.2 17226.0 17523.6 17661.5 17729.6 53157.2 53506.7 53768.5 55147.7 55861.0 70785.3 71497.0 71599.0 71663.0 71931.6 12513.9 13137.1 14770.4 15035.8 15134.7 23173.8 24034.0 24072.4 24326.9 24673.4 18850.8 19064.0 19111.6 19224.9 19322.6 16824.6 17121.8 17150.8 17561.2 17684.6 18628.4 19206.7 19246.0 19705.9 19757.8 14429.9 14496.0 14737.9 14743.2 14784.3 18942.7 18954.2 19001.5 19005.4 19164.4 16:31:32 INFO - PID 12490 | 16:31:32 INFO - PID 12490 | [#3] mootools.html Cycles:180 Average:8321.03 Median:2568.42 stddev:5662.47 (220.5%) stddev-sans-first:5654.04 16:31:32 INFO - PID 12490 | Values: 1336.6 1374.2 1405.5 1410.1 1418.4 11758.9 12283.1 13365.0 13766.5 13776.6 13469.1 13554.9 13561.9 13580.0 13615.7 2401.6 2541.6 2594.4 2595.7 2598.4 2654.1 2676.0 2676.9 2677.8 2681.1 2551.9 2555.2 2564.4 2570.7 2576.2 2429.5 2434.0 2470.8 2516.3 2538.5 2477.0 2511.8 2560.8 2566.2 2571.5 13763.9 13774.5 13856.5 13888.8 13924.2 7547.6 7824.5 7824.9 7826.9 7894.6 4591.7 4811.4 4917.5 4918.3 4920.6 1793.1 1823.8 1840.8 1878.8 1883.0 21889.2 21972.5 22013.3 22075.9 22122.8 6451.7 7026.6 7090.7 7292.5 7295.0 14734.9 14881.3 14917.7 14923.5 14927.7 7381.1 7486.0 7516.1 7531.5 7534.5 6806.6 6976.4 7057.3 7135.5 7139.2 5037.8 5083.2 5094.3 5136.4 5160.3 1507.9 1521.6 1545.7 1552.9 1560.5 804.9 813.2 824.7 844.8 865.0 6455.8 6736.9 6752.9 7728.0 7976.8 914.6 936.7 974.5 990.6 991.5 4367.5 4653.8 4776.0 4787.6 4871.0 18175.8 18432.2 18721.3 18722.3 18748.9 18087.7 18216.1 18721.0 18757.2 18758.4 10705.0 10844.3 10848.1 10887.2 10926.9 6857.2 7209.7 7348.7 7423.6 7521.8 15993.6 16410.4 16488.8 16492.0 16528.3 15989.2 16483.2 16483.5 16518.6 16797.4 10061.9 10286.9 10619.4 11115.9 11227.6 12422.4 12528.6 12554.4 12576.1 12595.1 9393.6 9846.7 9971.5 10081.3 10333.9 9230.7 9490.0 9531.9 9583.8 9613.5 8369.3 8437.9 8466.9 8492.5 8515.8 6395.2 6446.4 6613.0 6615.7 6637.6 6103.7 6164.4 6219.4 6223.1 6299.4 16:31:32 INFO - PID 12490 | 16:31:32 INFO - PID 12490 | [#4] prototype.html Cycles:180 Average:5481.90 Median:6065.74 stddev:1539.54 (25.4%) stddev-sans-first:1497.55 16:31:32 INFO - PID 12490 | Values: 488.8 500.1 517.7 524.3 525.9 6113.8 6203.4 6220.1 6301.2 6353.7 5978.3 6046.2 6065.3 6108.8 6156.5 4859.7 4949.2 4964.2 4966.4 4969.8 4826.1 4913.4 4916.5 4951.5 4954.5 4823.6 4910.1 4937.8 4938.4 4957.5 4810.9 4912.5 4945.1 4975.5 4977.4 4402.0 4441.9 4450.9 4495.4 4507.9 6015.7 6040.0 6047.5 6066.2 6069.0 5659.9 5669.1 5679.4 5697.9 5729.5 6314.5 6333.7 6433.2 6465.4 6465.9 4853.4 4861.8 4871.9 4899.6 4917.1 6778.7 6851.8 6865.4 6899.7 6940.6 4941.6 4997.7 5018.5 5023.9 5029.9 5056.8 5083.7 5095.2 5097.6 5114.7 5619.8 5643.3 5649.9 5706.5 5739.9 6503.3 6534.4 6553.2 6559.7 6604.9 1688.3 1717.8 1717.8 1727.0 1768.6 1184.9 1218.5 1220.9 1230.4 1233.7 5668.3 5682.4 5694.2 5694.9 5697.7 6440.5 6475.4 6504.5 6527.3 6553.3 5704.4 5709.3 5735.0 5785.8 5801.2 3531.8 3540.6 3548.6 3548.7 3566.5 6457.1 6530.4 6552.1 6584.7 6598.8 6876.0 6928.7 6933.2 6956.2 7000.1 6243.3 6396.6 6467.3 6524.3 6532.5 6623.9 6638.7 6649.2 6698.4 6756.7 6453.2 6642.5 6747.6 6748.7 6757.5 6513.7 6547.7 6594.4 6604.7 6624.2 4948.5 5006.5 5033.3 5039.6 5042.3 6696.8 6722.5 6735.4 6763.7 6792.7 6462.1 6524.7 6540.8 6574.3 6596.9 6479.7 6493.4 6502.2 6577.6 6623.8 6193.2 6211.0 6398.8 6401.9 6427.6 6477.6 6484.7 6490.5 6545.6 6579.9 6164.6 6180.8 6215.7 6302.1 6346.4 16:31:32 INFO - PID 12490 | 16:31:32 INFO - PID 12490 | [#5] yui.html Cycles:180 Average:22394.49 Median:18828.89 stddev:29897.58 (158.8%) stddev-sans-first:29937.86 16:31:32 INFO - PID 12490 | Values: 893.1 899.4 922.2 926.0 926.9 16673.4 17749.7 18525.2 18568.2 18592.2 16058.4 16074.6 16543.4 20366.4 20651.0 1013.6 1045.1 1049.2 1049.8 1050.6 1023.6 1046.8 1048.9 1050.0 1062.5 1113.4 1115.0 1116.4 1116.7 1118.6 1100.4 1100.6 1101.1 1103.4 1104.3 809.0 811.7 811.7 812.0 815.5 18066.4 18245.6 18900.2 19046.8 19177.7 20107.2 20178.4 20688.8 20691.1 20714.1 15794.8 15926.3 15974.0 15995.3 16236.9 3558.0 3576.7 3590.7 3591.6 3592.7 112262.0 115500.4 117386.0 121057.4 124207.0 16175.9 16540.1 16570.9 16586.9 16599.1 27194.5 29166.0 29203.6 29290.0 29471.6 8730.5 8790.9 8811.3 8824.9 8827.0 4094.5 4177.0 4195.9 4207.7 4255.4 4975.6 5001.6 5072.3 5097.3 5110.5 946.8 992.5 997.1 1002.0 1004.1 639.5 656.4 662.7 684.7 684.8 11221.4 12914.3 13185.6 13410.6 13743.3 628.9 664.9 667.6 669.3 678.8 5189.4 5342.3 5441.7 5464.8 6265.6 102428.0 102472.5 103525.0 104196.0 105192.0 86168.1 90397.1 91392.0 91463.0 93199.0 75731.6 77236.6 78627.6 79140.6 79747.6 11806.2 12072.9 12586.6 12746.6 12854.6 34067.7 36516.6 36909.6 37111.0 37277.8 63548.4 67710.6 67860.3 67880.0 69130.3 16189.4 16284.0 16323.9 16428.4 16471.0 18530.5 19338.4 19581.6 20331.6 20872.2 17103.7 17565.6 17850.7 18757.5 18974.9 17482.1 17547.8 18299.7 18337.3 19062.2 16863.3 17150.7 17999.3 18146.4 18256.1 10945.5 11407.1 11593.4 11761.9 11871.7 13228.7 13328.2 13367.6 13905.4 14098.4 16:31:32 INFO - PID 12490 | -------- Summary: end -------- 16:31:32 INFO - PID 12490 | 16:31:33 INFO - TEST-INFO | 12490: exit 0 16:31:33 INFO - TEST-OK | dromaeo_css | took 1111548ms 16:31:33 INFO - TEST-START | kraken 16:31:33 INFO - Initialising browser for kraken test... 16:31:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44935/getInfo.html -profile /tmp/tmpfxWE0X/profile 16:31:33 INFO - TEST-INFO | started process 12847 (/builds/slave/test/build/application/firefox/firefox http://localhost:44935/getInfo.html) 16:31:38 INFO - TEST-INFO | 12847: exit 0 16:31:38 INFO - Browser initialized. 16:31:38 INFO - Running cycle 1/1 for kraken test... 16:31:38 INFO - TEST-INFO | started process 13056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfxWE0X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:39 INFO - PID 13056 | 16:31:39 INFO - PID 13056 | (/builds/slave/test/build/application/firefox/firefox:13104): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:31:39 INFO - PID 13056 | 16:31:49 INFO - PID 13056 | RSS: Main: 171192320 16:31:49 INFO - PID 13056 | 16:31:52 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44935/tests/kraken/driver.html?testName=audio-beat-detection) 16:31:53 INFO - PID 13056 | RSS: Main: 177123328 16:31:53 INFO - PID 13056 | 16:31:55 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44935/tests/kraken/driver.html?testName=audio-dft) 16:31:56 INFO - PID 13056 | RSS: Main: 177532928 16:31:56 INFO - PID 13056 | 16:31:59 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44935/tests/kraken/driver.html?testName=audio-fft) 16:32:00 INFO - PID 13056 | RSS: Main: 170909696 16:32:00 INFO - PID 13056 | 16:32:02 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44935/tests/kraken/driver.html?testName=audio-oscillator) 16:32:02 INFO - PID 13056 | RSS: Main: 171364352 16:32:02 INFO - PID 13056 | 16:32:05 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44935/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:32:05 INFO - PID 13056 | RSS: Main: 172142592 16:32:05 INFO - PID 13056 | 16:32:08 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44935/tests/kraken/driver.html?testName=imaging-darkroom) 16:32:09 INFO - PID 13056 | RSS: Main: 174477312 16:32:09 INFO - PID 13056 | 16:32:12 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44935/tests/kraken/driver.html?testName=imaging-desaturate) 16:32:13 INFO - PID 13056 | RSS: Main: 174723072 16:32:13 INFO - PID 13056 | 16:32:16 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44935/tests/kraken/driver.html?testName=json-parse-financial) 16:32:16 INFO - PID 13056 | RSS: Main: 174936064 16:32:16 INFO - PID 13056 | 16:32:18 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44935/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:32:19 INFO - PID 13056 | RSS: Main: 174956544 16:32:19 INFO - PID 13056 | 16:32:20 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:32:21 INFO - PID 13056 | RSS: Main: 172244992 16:32:21 INFO - PID 13056 | 16:32:23 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:32:24 INFO - PID 13056 | RSS: Main: 172232704 16:32:24 INFO - PID 13056 | 16:32:27 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:32:27 INFO - PID 13056 | RSS: Main: 172613632 16:32:27 INFO - PID 13056 | 16:32:30 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:32:31 INFO - PID 13056 | RSS: Main: 172990464 16:32:31 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | Cycle 1(1): loaded http://localhost:44935/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44935/tests/kraken/driver.html?testName=ai-astar) 16:32:33 INFO - PID 13056 | RSS: Main: 174317568 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | __start_tp_report 16:32:33 INFO - PID 13056 | _x_x_mozilla_page_load 16:32:33 INFO - PID 13056 | _x_x_mozilla_page_load_details 16:32:33 INFO - PID 13056 | |i|pagename|runs| 16:32:33 INFO - PID 13056 | |0;ai-astar;100;108;103;108;109;111;109;100;108;109 16:32:33 INFO - PID 13056 | |1;audio-beat-detection;152;118;141;175;120;150;144;122;194;119 16:32:33 INFO - PID 13056 | |2;audio-dft;164;163;166;163;164;166;165;163;169;163 16:32:33 INFO - PID 13056 | |3;audio-fft;75;74;75;181;77;76;75;75;160;74 16:32:33 INFO - PID 13056 | |4;audio-oscillator;79;79;136;79;79;78;135;78;79;133 16:32:33 INFO - PID 13056 | |5;imaging-gaussian-blur;115;114;114;115;114;114;116;115;115;116 16:32:33 INFO - PID 13056 | |6;imaging-darkroom;151;151;153;153;152;151;151;151;151;151 16:32:33 INFO - PID 13056 | |7;imaging-desaturate;94;94;94;95;95;95;94;94;94;94 16:32:33 INFO - PID 13056 | |8;json-parse-financial;57;57;56;56;56;55;58;57;55;56 16:32:33 INFO - PID 13056 | |9;json-stringify-tinderbox;54;54;54;54;55;54;54;55;54;54 16:32:33 INFO - PID 13056 | |10;stanford-crypto-aes;83;81;83;82;81;83;87;92;82;89 16:32:33 INFO - PID 13056 | |11;stanford-crypto-ccm;133;135;133;129;129;131;137;127;135;184 16:32:33 INFO - PID 13056 | |12;stanford-crypto-pbkdf2;176;174;175;176;183;172;174;170;181;182 16:32:33 INFO - PID 13056 | |13;stanford-crypto-sha256-iterative;71;76;69;70;69;70;68;69;67;70 16:32:33 INFO - PID 13056 | __end_tp_report 16:32:33 INFO - PID 13056 | __start_cc_report 16:32:33 INFO - PID 13056 | _x_x_mozilla_cycle_collect,977 16:32:33 INFO - PID 13056 | __end_cc_report 16:32:33 INFO - PID 13056 | __startTimestamp1501198353611__endTimestamp 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | ------- Summary: start ------- 16:32:33 INFO - PID 13056 | Number of tests: 14 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#0] ai-astar Cycles:10 Average:106.50 Median:108.50 stddev:3.98 (3.7%) stddev-sans-first:3.46 16:32:33 INFO - PID 13056 | Values: 100.0 108.0 103.0 108.0 109.0 111.0 109.0 100.0 108.0 109.0 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:147.00 stddev:25.67 (17.5%) stddev-sans-first:27.04 16:32:33 INFO - PID 13056 | Values: 152.0 118.0 141.0 175.0 120.0 150.0 144.0 122.0 194.0 119.0 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:1.96 (1.2%) stddev-sans-first:2.06 16:32:33 INFO - PID 13056 | Values: 164.0 163.0 166.0 163.0 164.0 166.0 165.0 163.0 169.0 163.0 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#3] audio-fft Cycles:10 Average:94.20 Median:75.00 stddev:40.53 (54.0%) stddev-sans-first:42.39 16:32:33 INFO - PID 13056 | Values: 75.0 74.0 75.0 181.0 77.0 76.0 75.0 75.0 160.0 74.0 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:79.00 stddev:27.04 (34.2%) stddev-sans-first:28.01 16:32:33 INFO - PID 13056 | Values: 79.0 79.0 136.0 79.0 79.0 78.0 135.0 78.0 79.0 133.0 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 16:32:33 INFO - PID 13056 | Values: 115.0 114.0 114.0 115.0 114.0 114.0 116.0 115.0 115.0 116.0 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 16:32:33 INFO - PID 13056 | Values: 151.0 151.0 153.0 153.0 152.0 151.0 151.0 151.0 151.0 151.0 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:32:33 INFO - PID 13056 | Values: 94.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 94.0 94.0 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:0.95 (1.7%) stddev-sans-first:0.97 16:32:33 INFO - PID 13056 | Values: 57.0 57.0 56.0 56.0 56.0 55.0 58.0 57.0 55.0 56.0 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 16:32:33 INFO - PID 13056 | Values: 54.0 54.0 54.0 54.0 55.0 54.0 54.0 55.0 54.0 54.0 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.00 stddev:3.74 (4.5%) stddev-sans-first:3.94 16:32:33 INFO - PID 13056 | Values: 83.0 81.0 83.0 82.0 81.0 83.0 87.0 92.0 82.0 89.0 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:134.00 stddev:16.71 (12.5%) stddev-sans-first:17.65 16:32:33 INFO - PID 13056 | Values: 133.0 135.0 133.0 129.0 129.0 131.0 137.0 127.0 135.0 184.0 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:176.00 stddev:4.35 (2.5%) stddev-sans-first:4.61 16:32:33 INFO - PID 13056 | Values: 176.0 174.0 175.0 176.0 183.0 172.0 174.0 170.0 181.0 182.0 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:2.42 (3.5%) stddev-sans-first:2.54 16:32:33 INFO - PID 13056 | Values: 71.0 76.0 69.0 70.0 69.0 70.0 68.0 69.0 67.0 70.0 16:32:33 INFO - PID 13056 | -------- Summary: end -------- 16:32:33 INFO - PID 13056 | 16:32:33 INFO - PID 13056 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:32:34 INFO - TEST-INFO | 13056: exit 0 16:32:34 INFO - TEST-OK | kraken | took 61294ms 16:32:34 INFO - SUITE-END | took 1172s 16:32:34 INFO - Completed test suite (00:19:33) 16:32:34 INFO - javascript benchmark 16:32:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8442.785107133723, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.7193152616246, 3161.588993430854, 3167.6832316768314, 3185.3151572411925, 3209.1335339458346, 6053.727582258798, 6118.908216376758, 6193.969030154849, 6194.163787888634, 6228.22147231596, 6218.62688238706, 6253.687315634212, 6305.369463053692, 6321.7155228014735, 6329.0, 5650.434956504358, 5682.374938756733, 5757.539396848242, 5796.82609521715, 5856.385079566648, 5578.30271216098, 5596.804111856086, 5662.773489060432, 5707.914381284284, 5723.799667011655, 5654.462826031541, 5724.398938111522, 5731.025725626632, 5739.1965124882345, 5746.339170995348, 5623.409541998072, 5641.802536911188, 5713.114467257582, 5718.1136923776885, 5744.827655170351, 5544.944550554484, 5615.438456154393, 5660.094384898438, 5676.772929082832, 5678.858028549278, 6001.789937352215, 6030.577859549833, 6054.091886217058, 6059.878802423971, 6069.423404776539, 6666.0, 6666.566673166277, 6671.432928201109, 6672.099266598995, 6677.3656502632175, 6726.93273067268, 6740.460763138937, 6741.056252124707, 6742.056112144303, 6742.966285168592, 6151.446369826737, 6199.442050215503, 6203.410675985729, 6238.750449981995, 6242.6878656067465, 6886.896696549556, 6887.380135787803, 6888.862222755517, 6918.757843475454, 6922.930770692329, 6511.0, 6521.869562608721, 6596.274409814917, 6601.900971485432, 6616.172978377703, 6523.510736694767, 6592.17597800275, 6603.405693487609, 6692.464602831762, 6705.865882682319, 6573.769918052941, 6596.0, 6673.232578253563, 6678.7662431815625, 6686.933130668631, 6732.427743641747, 6738.831529211809, 6740.359665831738, 6753.831154221184, 6784.728610855511, 5321.095413779667, 5329.173978033411, 5407.161889907071, 5421.403645598981, 5424.538914192338, 4572.908541829145, 4574.290984897346, 4633.513481084505, 4642.3500709900645, 4666.393368862026, 5766.625169363978, 5833.095870140135, 5835.649861008353, 5852.502537284294, 5854.502367298827, 6696.966515167393, 6699.665016749143, 6709.027191057269, 6719.294474080249, 6727.125473688389, 5766.855828604234, 5775.0, 5821.126830975388, 5860.501857342174, 5891.3814049525035, 5870.119482077637, 5901.911471327933, 5907.940920590825, 5963.970180149158, 5983.760649573968, 6368.713407896656, 6467.0, 6479.773207937794, 6480.773172939019, 6573.408393244631, 6609.405153536205, 6615.239247486601, 6624.105745724266, 6708.262091170065, 6712.798616041527, 6574.737010519526, 6581.703823327866, 6587.769428069994, 6602.438792702674, 6606.570572912745, 6576.408123268929, 6612.900806488003, 6685.0, 6687.0, 6697.9953007049335, 6660.966695166493, 6731.124953755981, 6738.561993470409, 6840.48696347766, 6853.109095817512, 6452.645104519296, 6471.320511346429, 6487.18910136233, 6544.509161812978, 6547.214334279917, 6448.387403196689, 6457.192850893638, 6465.353464653497, 6547.214334279917, 6555.836104097245, 6379.202599675041, 6391.520635952415, 6484.416402523795, 6490.545661803629, 6494.090827284279, 6428.77853207889, 6440.4525615321345, 6589.835254118685, 6590.373914478117, 6621.702023408862, 6288.748450061947, 6290.2766181889665, 6328.114064030948, 6341.365863413622, 6373.235211774617], "value": 6094.4311244744185, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.6123460738845, 835.2482765511041, 869.791250099976, 877.4866702978757, 1185.3480585677885, 30395.39209215817, 30855.228619284502, 31003.84498077509, 41260.381094283606, 41504.37743433851, 41686.7915660422, 42223.0, 42258.154836903246, 42329.365059524134, 42390.36414453786, 7423.369013633847, 7857.567833769154, 8017.078036025844, 8105.675772969074, 8108.959455202716, 7882.093559240703, 7951.40364472664, 7963.044434667848, 8004.51972881629, 8016.278534931855, 7979.0, 8034.0, 8038.397120215978, 8042.798930026737, 8049.0, 7878.881816772753, 7900.7629771106385, 7923.801904952394, 7951.16512766157, 7967.16344783798, 7787.221277872168, 7860.410469214775, 7863.213678632091, 7868.173841746591, 7894.4079194060105, 38093.61906380928, 38342.61657383418, 38358.80820595879, 38373.0, 38400.61599383999, 3545.06055895188, 3584.910377240564, 3588.5873124590744, 3589.2821435712963, 3595.928081438383, 30780.0, 31013.534796978063, 31143.221419464695, 31175.220619484466, 31368.529472057937, 4844.539768721966, 4849.660523763338, 4885.413750349945, 4889.902201955941, 4934.728589927553, 181629.0, 182694.0, 182986.0, 184068.0796596022, 184358.0, 47830.5216947833, 47920.76039619849, 47957.0, 47963.0, 48182.75908620434, 50451.24323135156, 50511.49488505141, 50548.24177637338, 50694.0, 50801.237981430306, 16266.18669066542, 16518.917405412896, 16573.08848013347, 16591.751123733153, 16624.168791560372, 12153.210041347284, 12334.074944379028, 12349.135560510678, 12352.320622365676, 13660.795088073686, 13688.863111368959, 13722.0, 13812.309384530734, 14064.226467544384, 14092.224927629079, 5397.3523177218985, 5498.367687715964, 5549.556035517149, 5561.499465048165, 5589.580781441408, 977.5600979559226, 981.7545613596601, 1006.2704539209014, 1021.7292417509366, 1022.3610243597751, 21901.890490547445, 22332.665010024863, 22332.88833555822, 23169.768302316763, 23194.3041708749, 1082.3343643659093, 1110.711215084084, 1115.3085087245959, 1119.6641007697822, 1136.2557524821254, 11570.826437603442, 12196.39018049094, 12292.877071229352, 12347.567835125728, 12466.376681165906, 224698.0, 226233.0, 226312.0, 226477.0, 226897.0, 58045.70977145087, 58941.70529147327, 58948.41051589429, 59196.0, 59197.70401148053, 1490.1357212816756, 1493.2235237676348, 1499.9850001500063, 1510.7582786754067, 1523.5581681312517, 27020.32449188786, 27706.584401233595, 27995.300117497227, 28097.0, 28100.297492562033, 37978.81010594929, 50986.0, 51393.229101562756, 51677.0, 51721.22418163655, 198129.0, 198341.0, 199036.0, 199205.0, 200208.0, 30516.185476815397, 31464.0, 32077.35845283128, 35749.28501430009, 35937.46093808542, 40623.59376406198, 46491.53508464872, 46873.76563117163, 46908.29637555371, 47066.0, 31029.0691279262, 32125.0, 32132.83933580317, 32225.51661725123, 32244.35511289808, 29772.80908763625, 30311.545326819672, 30850.845745771127, 31312.843435782674, 31353.686463135076, 35891.64108358883, 36027.27945441129, 36296.0, 36307.63692363042, 36322.8183859079, 29619.407611848073, 30620.387592248477, 31068.378632427677, 31425.371492570477, 31578.0, 21622.486425950032, 23334.88332558394, 23724.406889827893, 23830.404239894142, 23859.880700596386], "value": 17335.939648210806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.8249833800689, 580.9796657117001, 584.862557299035, 588.8704485013297, 601.4166258729033, 22161.0, 22936.311910642686, 22942.426439339026, 22951.885240573814, 23054.0, 24030.75969240307, 25140.874295628495, 26235.3441163971, 26333.47333053338, 26360.0, 6580.835479113012, 6746.426553742937, 6749.493787965897, 6755.054292399068, 6757.864842703143, 6339.587926784768, 6666.500012499057, 6727.192736871582, 6733.629650369227, 6928.792136235921, 6918.8962165567555, 6934.68793904273, 6941.305869413043, 6943.72225110995, 6944.409725173341, 6893.896591551131, 6914.792556223296, 6916.23921368649, 6920.0, 6923.238443771181, 6763.256041835394, 6775.932240677579, 6791.626460544668, 6802.0, 6805.387515123613, 29859.70140298591, 31670.366592668248, 31751.364972700416, 31764.04707858768, 32203.838980804947, 1911.5603411215359, 1953.169902791308, 1953.658109830774, 1957.7944315846917, 1959.980400195994, 19510.414687559394, 20056.899715501477, 20088.09603567843, 20144.19423223084, 20157.899210504, 2491.6636254105824, 2496.5506208882393, 2570.9357266068496, 2570.948581028369, 2574.0604679291923, 128725.0, 131101.0, 131104.0, 131503.0, 131655.34172329077, 19849.503762406057, 21897.0, 21898.562028759334, 21922.355823313315, 22619.43451413728, 43627.781861090494, 43668.78165609215, 43747.56252437435, 43764.562354376685, 43768.78115609402, 11206.38364889939, 11218.943905280421, 11291.774164516664, 11440.199186056896, 11472.991827785596, 9159.450432974043, 9261.398009129385, 9405.623775049058, 9464.668736594185, 9523.095305945924, 8821.750453634282, 9468.857967130498, 9505.239580833517, 11478.655640330804, 11482.770344593062, 2632.447186090904, 2700.189943017087, 2700.6901652698425, 2754.9586756198673, 2796.9021084261954, 926.1340646495548, 945.9621615135318, 949.0604301741364, 970.1801977329145, 980.789130336981, 18734.531636708918, 19000.619987600447, 19039.904800476186, 19314.903425482782, 19637.018149092488, 990.9009099090033, 1016.4866742295094, 1020.9591616335264, 1025.9538320775582, 1040.9479526023667, 10287.43419111956, 10602.734931626772, 10632.574697012187, 10756.08573271265, 11010.39442830636, 491735.0, 507309.0, 508486.0, 509020.0, 509923.0, 113696.43151784354, 114773.0, 116237.0, 117683.99999999828, 119956.0, 1183.431952662718, 1217.5008246618843, 1238.9256644601173, 1246.1899765152723, 1255.0649765924445, 16412.17939103064, 17226.0, 17523.649527009642, 17661.470155895342, 17729.645407091528, 53157.20264195963, 53506.73246633742, 53768.462315376346, 55147.72426137843, 55861.0, 70785.29214707993, 71497.0, 71599.0, 71663.0, 71931.64034179796, 12513.93743031279, 13137.080404371985, 14770.409183632964, 15035.774463382839, 15134.697306054037, 23173.768262317837, 24034.0, 24072.398190045387, 24326.87836560806, 24673.38316542029, 18850.811491884906, 19064.04679766034, 19111.617767644846, 19224.903875480533, 19322.61354772925, 16824.57938551546, 17121.76176018292, 17150.828491714925, 17561.209745561224, 17684.64630707353, 18628.441146765617, 19206.7118993218, 19246.037698115317, 19705.901470492558, 19757.802421975597, 14429.855701442852, 14496.0, 14737.926310368379, 14743.18912459825, 14784.260786960394, 18942.715859262396, 18954.241830327184, 19001.524961876064, 19005.429837104908, 19164.425067248005], "value": 12522.312362696755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1336.6457888659504, 1374.237298299444, 1405.5431984605, 1410.1327683474667, 1418.3830033935233, 11758.941205293972, 12283.14018018739, 13364.997625178114, 13766.518171863987, 13776.58670239892, 13469.124506907045, 13554.93222533886, 13561.864381356208, 13580.0, 13615.727685446285, 2401.591729406005, 2541.606051062088, 2594.429225570381, 2595.6885173779174, 2598.44133511295, 2654.0843409023855, 2675.973240267602, 2676.8661566921674, 2677.799165062628, 2681.12863319421, 2551.872406379683, 2555.2078855554746, 2564.384547708546, 2570.678665166854, 2576.1756238003845, 2429.5019520998153, 2433.963490547634, 2470.8270421070533, 2516.3331717094984, 2538.5430622487943, 2476.987615061931, 2511.7739403453775, 2560.8207425480223, 2566.1531694540945, 2571.459993401388, 13763.931180344034, 13774.517891873737, 13856.515021974183, 13888.791668124986, 13924.234167120805, 7547.584882831442, 7824.452288339761, 7824.882626760603, 7826.882596761053, 7894.64474098667, 4591.724496530219, 4811.422629284508, 4917.532834380728, 4918.311436398907, 4920.606351491872, 1793.0944872839264, 1823.79026411963, 1840.7791065072142, 1878.7651543557056, 1883.0, 21889.233876814393, 21972.450688732908, 22013.339599812032, 22075.889620551956, 22122.778772212394, 6451.677416129175, 7026.613536255452, 7090.704097759402, 7292.489525733148, 7294.96352518234, 14734.852651473562, 14881.33034013472, 14917.70164596702, 14923.477678281208, 14927.701445971237, 7381.077365329334, 7486.0, 7516.135644400964, 7531.548107113591, 7534.54792712439, 6806.55757375769, 6976.407005404496, 7057.294270573005, 7135.536190147727, 7139.178994415604, 5037.848864533997, 5083.186690129635, 5094.2613321068975, 5136.409312928986, 5160.251763494272, 1507.9396824127132, 1521.634807646157, 1545.652228248635, 1552.9378824847106, 1560.4694403902727, 804.899387576553, 813.1705660226536, 824.7154731617583, 844.7507985144397, 865.0441262404952, 6455.838604034937, 6736.93263067363, 6752.898706519406, 7727.961360193163, 7976.800579985546, 914.6478605736839, 936.7096200177966, 974.468914441631, 990.5542505872386, 991.4893829677721, 4367.47590289161, 4653.790579423934, 4775.997040621439, 4787.569118779257, 4870.95129048705, 18175.81824181741, 18432.170552325177, 18721.344752933855, 18722.251109955723, 18748.906255468908, 18087.72868406975, 18216.08919554017, 18721.0, 18757.249710011718, 18758.437246882342, 10705.0, 10844.349339039525, 10848.077913377452, 10887.237893347548, 10926.945365273281, 6857.177138743184, 7209.671026555605, 7348.706051758084, 7423.628818559158, 7521.7743467696055, 15993.600159995627, 16410.425635102714, 16488.752668710218, 16492.0, 16528.25622846999, 15989.200539973188, 16483.175841208133, 16483.505494835175, 16518.587035323733, 16797.41209057726, 10061.89938100639, 10286.948565257126, 10619.36283822973, 11115.944420277847, 11227.607033753779, 12422.440990155284, 12528.624141275777, 12554.372281386077, 12576.119671622899, 12595.118341715992, 9393.577289022147, 9846.704598862045, 9971.45157016371, 10081.294309398272, 10333.896661033594, 9230.723078307661, 9489.952550237205, 9531.857022144535, 9583.808323833346, 9613.471259080818, 8369.330453563822, 8437.873431898404, 8466.872996905175, 8492.490450572985, 8515.787105322417, 6395.20059992501, 6446.387593178641, 6613.041109039066, 6615.735370585123, 6637.568558043712, 6103.725332359965, 6164.445199932027, 6219.378062193744, 6223.101953904103, 6299.433051025429], "value": 6117.135112060111, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.7922632881027, 500.1447524732708, 517.6609320894814, 524.2869697211792, 525.8536390668346, 6113.755449782004, 6203.441690247877, 6220.098085777565, 6301.1808464899495, 6353.682315884204, 5978.312494063184, 6046.183765191698, 6065.302490213627, 6108.755649774003, 6156.507479401648, 4859.659823812326, 4949.208126699728, 4964.156093464102, 4966.404031516205, 4969.801207951696, 4826.131296366652, 4913.361263035818, 4916.50834916509, 4951.504849515056, 4954.504549545035, 4823.589994850425, 4910.140725373063, 4937.753112344386, 4938.38270216223, 4957.529034741712, 4810.927836082462, 4912.533309335608, 4945.134601444751, 4975.5322179957, 4977.42759582649, 4401.955980440187, 4441.888952776174, 4450.933236001462, 4495.370648109268, 4507.864764057083, 6015.669138197398, 6040.0, 6047.518358002274, 6066.181065556182, 6068.969655151696, 5659.886802263932, 5669.149627555858, 5679.375268720438, 5697.857553561194, 5729.541636669056, 6314.526410519229, 6333.651649159295, 6433.163688720483, 6465.3857883501, 6465.935340646627, 4853.3690620219495, 4861.756912154378, 4871.926921096187, 4899.559039686445, 4917.114919314522, 6778.694958726771, 6851.760188393432, 6865.382115609619, 6899.655017249168, 6940.618265995368, 4941.6293777966075, 4997.675151115166, 5018.548330650259, 5023.874403139877, 5029.924551131736, 5056.84829455117, 5083.694978301313, 5095.184770436712, 5097.566706829887, 5114.744262786846, 5619.80330688424, 5643.266375371258, 5649.915251271234, 5706.4864162225595, 5739.913901291484, 6503.349665033459, 6534.379233972765, 6553.246376666649, 6559.704813283413, 6604.900926486107, 1688.3499852556608, 1717.7681013063327, 1717.7938647362396, 1726.9740953885703, 1768.5578605348662, 1184.8518935133109, 1218.524775337619, 1220.9328486933305, 1230.4155526125019, 1233.747081848219, 5668.348139963874, 5682.374938756733, 5694.209837179752, 5694.914576281359, 5697.743601537941, 6440.516961227927, 6475.384838440341, 6504.479641628658, 6527.3472652734345, 6553.279139294674, 5704.401037890962, 5709.314882214161, 5734.971325143348, 5785.82642520725, 5801.158831969426, 3531.805750683686, 3540.6105328413855, 3548.556430446194, 3548.722459914429, 3566.4828599853395, 6457.096006559085, 6530.412262896362, 6552.14822073137, 6584.703688334036, 6598.8350291243105, 6875.965620171867, 6928.688209030605, 6933.168019837551, 6956.165260168812, 7000.089988301488, 6243.314305137678, 6396.648184349812, 6467.256265529524, 6524.314946930599, 6532.510061745388, 6623.900641490285, 6638.668066596748, 6649.168853893263, 6698.39714425704, 6756.702721074858, 6453.1610890583925, 6642.535022548375, 6747.628880411625, 6748.662566871735, 6757.547127367639, 6513.706883190173, 6547.738090476328, 6594.439472644879, 6604.669766511559, 6624.238212605612, 4948.505149485023, 5006.549410552922, 5033.320501732219, 5039.596832253337, 5042.29407882904, 6696.7656132035145, 6722.453835617737, 6735.440532597778, 6763.6618169092335, 6792.694328755119, 6462.127612772216, 6524.739010439529, 6540.803775886731, 6574.309697481695, 6596.90104648421, 6479.708413121327, 6493.448056915215, 6502.187226596676, 6577.6053436793945, 6623.768168114093, 6193.163922870355, 6210.968945155245, 6398.824399704123, 6401.927075003931, 6427.55007149495, 6477.574933514619, 6484.740610375721, 6490.545661803817, 6545.607263564201, 6579.901301480578, 6164.568480206342, 6180.752769889334, 6215.658138802229, 6302.117703521602, 6346.415154663866], "value": 5028.464590830369, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.1068931068932, 899.4108858697554, 922.2022950148124, 926.0322962504184, 926.9490178040205, 16673.41643042494, 17749.7337539937, 18525.166367513462, 18568.16443260053, 18592.163352649146, 16058.357665693358, 16074.59813504663, 16543.42098026569, 20366.389008329774, 20651.0, 1013.5742987945063, 1045.0646671229244, 1049.1868801678684, 1049.8477720730489, 1050.6060227414719, 1023.5956797065155, 1046.8272734998754, 1048.8584041154422, 1050.033968748753, 1062.5165549674919, 1113.3987646670787, 1114.9944250278777, 1116.4083035990939, 1116.743149075713, 1118.552578968415, 1100.350793032115, 1100.5817789240039, 1101.0860985382114, 1103.448275862069, 1104.2987702808734, 809.0332053196432, 811.6631597886928, 811.7118422959824, 812.0093485947135, 815.5066184958133, 18066.36767713124, 18245.63508729818, 18900.243990240375, 19046.809531904782, 19177.712334314998, 20107.195712171495, 20178.394648160433, 20688.793112068837, 20691.06890189945, 20714.067866946025, 15794.842051579451, 15926.283317250636, 15974.041557506587, 15995.280212390471, 16236.918815405965, 3557.964420355789, 3576.695980841632, 3590.7306951978444, 3591.5510561179854, 3592.7305452091196, 112262.0, 115500.42249788698, 117386.0, 121057.39471302675, 124207.0, 16175.919120404322, 16540.09029503365, 16570.917145414194, 16586.917065414596, 16599.087050212114, 27194.456110877672, 29166.0, 29203.56194657082, 29290.0, 29471.557926631118, 8730.476171429607, 8790.912090879137, 8811.295096392274, 8824.911750882537, 8827.029026807046, 4094.549599544048, 4176.979115104405, 4195.8741237762915, 4207.684423668237, 4255.3829694694095, 4975.552200301918, 5001.599872010231, 5072.340595722606, 5097.311862898536, 5110.540051395318, 946.8248374050685, 992.5384696116196, 997.1175509673991, 1001.9549120289604, 1004.0762498501397, 639.5427269502328, 656.4125108028288, 662.7382184037278, 684.7055766020559, 684.7842929477199, 11221.382823944761, 12914.289714065628, 13185.60443186706, 13410.597682069554, 13743.312834358243, 628.8585068359582, 664.9434798042124, 667.5827607745159, 669.2872091222929, 678.8404724889647, 5189.351331083614, 5342.305500285016, 5441.709483411008, 5464.836054918359, 6265.624062556261, 102428.0, 102472.48763756282, 103525.0, 104196.0, 105192.0, 86168.13831861726, 90397.09602903886, 91392.0, 91463.0, 93199.0, 75731.62134189405, 77236.61381693055, 78627.60686196532, 79140.60429697814, 79747.60126199448, 11806.1821714025, 12072.879271207175, 12586.622401327975, 12746.617601471971, 12854.614361569167, 34067.65932340645, 36516.634833651326, 36909.630903691694, 37111.0, 37277.81361093177, 63548.364516354246, 67710.63982925883, 67860.3213967854, 67880.0, 69130.30869691238, 16189.381061893717, 16284.0, 16323.918380408022, 16428.42500512476, 16471.0, 18530.536736581154, 19338.4198474046, 19581.60836783228, 20331.59336813285, 20872.165113395902, 17103.657926841144, 17565.648687025932, 17850.732239016164, 18757.531061723566, 18974.905125474284, 17482.125893705517, 17547.824521754617, 18299.72550411718, 18337.266509339475, 19062.237510499424, 16863.325466981183, 17150.656986860442, 17999.280028799225, 18146.364877229233, 18256.08719564043, 10945.507452164513, 11407.087433005505, 11593.362365070003, 11761.88238117608, 11871.703207419883, 13228.669283267995, 13328.200307981164, 13367.598972030855, 13905.446557835112, 14098.36557354901], "value": 8898.920658720797, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 108.0, 103.0, 108.0, 109.0, 111.0, 109.0, 100.0, 108.0, 109.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 118.0, 141.0, 175.0, 120.0, 150.0, 144.0, 122.0, 194.0, 119.0], "value": 143.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 166.0, 163.0, 164.0, 166.0, 165.0, 163.0, 169.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 181.0, 77.0, 76.0, 75.0, 75.0, 160.0, 74.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 136.0, 79.0, 79.0, 78.0, 135.0, 78.0, 79.0, 133.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 115.0, 114.0, 114.0, 116.0, 115.0, 115.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 153.0, 153.0, 152.0, 151.0, 151.0, 151.0, 151.0, 151.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 56.0, 56.0, 55.0, 58.0, 57.0, 55.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 83.0, 82.0, 81.0, 83.0, 87.0, 92.0, 82.0, 89.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 135.0, 133.0, 129.0, 129.0, 131.0, 137.0, 127.0, 135.0, 184.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 175.0, 176.0, 183.0, 172.0, 174.0, 170.0, 181.0, 182.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 69.0, 70.0, 69.0, 70.0, 68.0, 69.0, 67.0, 70.0], "value": 69.9, "unit": "score"}]}]} 16:32:34 INFO - Return code: 0 16:32:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:32:34 INFO - # TBPL SUCCESS # 16:32:34 INFO - Running post-action listener: _package_coverage_data 16:32:34 INFO - Running post-action listener: _resource_record_post_action 16:32:34 INFO - [mozharness: 2017-07-27 23:32:34.893483Z] Finished run-tests step (success) 16:32:34 INFO - Running post-run listener: _resource_record_post_run 16:32:34 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 438272000; Read time: 16; Write time: 317380 16:32:34 INFO - TinderboxPrint: CPU usage
13.1% 16:32:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:32:34 INFO - TinderboxPrint: I/O write bytes / time
438,272,000 / 317,380 16:32:34 INFO - TinderboxPrint: CPU idle
8,257.9 (86.9%) 16:32:34 INFO - TinderboxPrint: CPU user
1,199.7 (12.6%) 16:32:34 INFO - TinderboxPrint: Swap in / out
0 / 0 16:32:34 INFO - install - Wall time: 19s; CPU: 12.0%; Read bytes: 0; Write bytes: 113438720; Read time: 0; Write time: 86000 16:32:34 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:32:34 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 324833280; Read time: 16; Write time: 231380 16:32:35 INFO - Running post-run listener: _upload_blobber_files 16:32:35 INFO - Blob upload gear active. 16:32:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:32:35 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 16:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:32:35 INFO - (blobuploader) - INFO - Open directory for files ... 16:32:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:32:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:32:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:36 INFO - (blobuploader) - INFO - Done attempting. 16:32:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:32:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:32:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:37 INFO - (blobuploader) - INFO - Done attempting. 16:32:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:32:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:32:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:41 INFO - (blobuploader) - INFO - Done attempting. 16:32:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:32:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:32:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:42 INFO - (blobuploader) - INFO - Done attempting. 16:32:42 INFO - (blobuploader) - INFO - Iteration through files over. 16:32:42 INFO - Return code: 0 16:32:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:32:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:32:42 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b101e14692f7d2d7b4b459201ce5786470d43adc535d8a1efe21da5d661c0a722e53a4b1a57f160e7493f7f5bd4489fe76d2c9b79bd9188cc5eb8df7c7a9c6af", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08f768ea87c9777621bd2f8aee5d9a7a4962f9773b042db5fbff9e4058bad8ecba40f0c31aadb1e6ae42423a0b5603e308db9aa934bbffdca949f71bcc825e4e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39bd6ba2048ccffe2d4aaf9db8274ad42a5cae2010f006ec5b5046d17f79d864bed8f213fa11d70b1c0935ece48f73313825fcabb79907a75d6396e62ecb2e9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73d1c6eda6b03a1d6451b77db8e97f030259fbcf7d8fba8a3374bab02d6c60977f6f0feb45aa5fe660fcdfa9d45c8a4350e4d6d609aedbabf693f473b865b3bd"} 16:32:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:32:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:32:42 INFO - Contents: 16:32:42 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b101e14692f7d2d7b4b459201ce5786470d43adc535d8a1efe21da5d661c0a722e53a4b1a57f160e7493f7f5bd4489fe76d2c9b79bd9188cc5eb8df7c7a9c6af", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08f768ea87c9777621bd2f8aee5d9a7a4962f9773b042db5fbff9e4058bad8ecba40f0c31aadb1e6ae42423a0b5603e308db9aa934bbffdca949f71bcc825e4e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39bd6ba2048ccffe2d4aaf9db8274ad42a5cae2010f006ec5b5046d17f79d864bed8f213fa11d70b1c0935ece48f73313825fcabb79907a75d6396e62ecb2e9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73d1c6eda6b03a1d6451b77db8e97f030259fbcf7d8fba8a3374bab02d6c60977f6f0feb45aa5fe660fcdfa9d45c8a4350e4d6d609aedbabf693f473b865b3bd"} 16:32:42 INFO - Running post-run listener: copy_logs_to_upload_dir 16:32:42 INFO - Copying logs to upload dir... 16:32:42 INFO - mkdir: /builds/slave/test/build/upload/logs 16:32:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.465352 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-27 16:32:42.380911) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 16:32:42.384252) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b101e14692f7d2d7b4b459201ce5786470d43adc535d8a1efe21da5d661c0a722e53a4b1a57f160e7493f7f5bd4489fe76d2c9b79bd9188cc5eb8df7c7a9c6af", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08f768ea87c9777621bd2f8aee5d9a7a4962f9773b042db5fbff9e4058bad8ecba40f0c31aadb1e6ae42423a0b5603e308db9aa934bbffdca949f71bcc825e4e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39bd6ba2048ccffe2d4aaf9db8274ad42a5cae2010f006ec5b5046d17f79d864bed8f213fa11d70b1c0935ece48f73313825fcabb79907a75d6396e62ecb2e9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73d1c6eda6b03a1d6451b77db8e97f030259fbcf7d8fba8a3374bab02d6c60977f6f0feb45aa5fe660fcdfa9d45c8a4350e4d6d609aedbabf693f473b865b3bd"} build_url:https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011093 build_url: 'https://queue.taskcluster.net/v1/task/ZqZj14WcSnmyjGd7pzYZYQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b101e14692f7d2d7b4b459201ce5786470d43adc535d8a1efe21da5d661c0a722e53a4b1a57f160e7493f7f5bd4489fe76d2c9b79bd9188cc5eb8df7c7a9c6af", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/08f768ea87c9777621bd2f8aee5d9a7a4962f9773b042db5fbff9e4058bad8ecba40f0c31aadb1e6ae42423a0b5603e308db9aa934bbffdca949f71bcc825e4e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39bd6ba2048ccffe2d4aaf9db8274ad42a5cae2010f006ec5b5046d17f79d864bed8f213fa11d70b1c0935ece48f73313825fcabb79907a75d6396e62ecb2e9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/73d1c6eda6b03a1d6451b77db8e97f030259fbcf7d8fba8a3374bab02d6c60977f6f0feb45aa5fe660fcdfa9d45c8a4350e4d6d609aedbabf693f473b865b3bd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 16:32:42.408503) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:32:42.408861) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1501196648.415431-1643136342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:32:42.491498) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 16:32:42.491813) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 16:32:42.492090) ========= ========= Total master_lag: 0.15 =========