builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-033 starttime: 1495746606.48 results: success (0) revision: bdf2d1918fb0b434ab8782d003afbe3f9639cd45 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 14:10:06.482707) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 14:10:06.483094) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 14:10:06.483366) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 14:10:06.511209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:10:06.511468) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 14:10:06-- 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% 224M=0s 2017-05-25 14:10:06 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.375824 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:10:06.906440) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:10:06.906722) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017515 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:10:06.955432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 14:10:06.955734) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bdf2d1918fb0b434ab8782d003afbe3f9639cd45 --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 bdf2d1918fb0b434ab8782d003afbe3f9639cd45 --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=edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 14:10:07,110 truncating revision to first 12 chars 2017-05-25 14:10:07,111 Setting DEBUG logging. 2017-05-25 14:10:07,111 attempt 1/10 2017-05-25 14:10:07,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bdf2d1918fb0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 14:10:08,179 unpacking tar archive at: mozilla-central-bdf2d1918fb0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.372661 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 14:10:08.342653) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 14:10:08.346007) ========= script_repo_revision: bdf2d1918fb0b434ab8782d003afbe3f9639cd45 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 14:10:08.346429) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 14:10:08.346695) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 14:10:08.356225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-05-25 14:10:08.356492) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:10:08 INFO - MultiFileLogger online at 20170525 14:10:08 in /builds/slave/test 14:10:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:10:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:10:08 INFO - {'append_to_log': False, 14:10:08 INFO - 'base_work_dir': '/builds/slave/test', 14:10:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:10:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:10:08 INFO - 'branch': 'Firefox-Non-PGO', 14:10:08 INFO - 'buildbot_json_path': 'buildprops.json', 14:10:08 INFO - 'config_files': ('talos/linux_config.py',), 14:10:08 INFO - 'default_actions': ('clobber', 14:10:08 INFO - 'read-buildbot-config', 14:10:08 INFO - 'download-and-extract', 14:10:08 INFO - 'populate-webroot', 14:10:08 INFO - 'create-virtualenv', 14:10:08 INFO - 'install', 14:10:08 INFO - 'run-tests'), 14:10:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:10:08 INFO - 'download_minidump_stackwalk': True, 14:10:08 INFO - 'download_symbols': 'ondemand', 14:10:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:10:08 INFO - 'tooltool.py': '/tools/tooltool.py', 14:10:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:10:08 INFO - '/tools/misc-python/virtualenv.py')}, 14:10:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:10:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:10:08 INFO - 'gecko_profile': False, 14:10:08 INFO - 'gecko_profile_interval': 0, 14:10:08 INFO - 'installer_path': 'installer.exe', 14:10:08 INFO - 'log_level': 'info', 14:10:08 INFO - 'log_name': 'talos', 14:10:08 INFO - 'log_to_console': True, 14:10:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:10:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:10:08 INFO - 'opt_config_files': (), 14:10:08 INFO - 'pip_index': False, 14:10:08 INFO - 'suite': 'dromaeojs-e10s', 14:10:08 INFO - 'system_bits': '32', 14:10:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:10:08 INFO - 'title': 'talos-linux64-ix-033', 14:10:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:10:08 INFO - 'use_talos_json': True, 14:10:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:10:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:10:08 INFO - 'work_dir': 'build'} 14:10:08 INFO - [mozharness: 2017-05-25 21:10:08.613763Z] Running clobber step. 14:10:08 INFO - Running pre-action listener: _resource_record_pre_action 14:10:08 INFO - Running main action method: clobber 14:10:08 INFO - rmtree: /builds/slave/test/build 14:10:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:10:09 INFO - Running post-action listener: _resource_record_post_action 14:10:09 INFO - [mozharness: 2017-05-25 21:10:09.634418Z] Finished clobber step (success) 14:10:09 INFO - [mozharness: 2017-05-25 21:10:09.634520Z] Running read-buildbot-config step. 14:10:09 INFO - Running pre-action listener: _resource_record_pre_action 14:10:09 INFO - Running main action method: read_buildbot_config 14:10:09 INFO - Using buildbot properties: 14:10:09 INFO - { 14:10:09 INFO - "project": "", 14:10:09 INFO - "product": "firefox", 14:10:09 INFO - "who": "ryanvm@gmail.com", 14:10:09 INFO - "installer_path": "public/build/target.tar.bz2", 14:10:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:10:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:10:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:10:09 INFO - "stage_platform": "linux64", 14:10:09 INFO - "basedir": "/builds/slave/test", 14:10:09 INFO - "buildnumber": 634, 14:10:09 INFO - "platform": "ubuntu64_hw", 14:10:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:10:09 INFO - "slavebuilddir": "test", 14:10:09 INFO - "taskId": "WZreQieCRdGE7IeO0BHx1w", 14:10:09 INFO - "branch": "mozilla-central", 14:10:09 INFO - "script_repo_revision": "production", 14:10:09 INFO - "revision": "bdf2d1918fb0b434ab8782d003afbe3f9639cd45", 14:10:09 INFO - "slavename": "talos-linux64-ix-033", 14:10:09 INFO - "repo_path": "mozilla-central" 14:10:09 INFO - } 14:10:09 INFO - Finding installer, test and symbols from parent task. 14:10:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WZreQieCRdGE7IeO0BHx1w'}, attempt #1 14:10:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WZreQieCRdGE7IeO0BHx1w'}, attempt #1 14:10:10 INFO - Task dependencies: ehNlczAfRMOYxZntbQ27Ig 14:10:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig'}, attempt #1 14:10:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.tar.bz2 14:10:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/test_packages.json 14:10:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.crashreporter-symbols.zip 14:10:11 INFO - Running post-action listener: _resource_record_post_action 14:10:11 INFO - [mozharness: 2017-05-25 21:10:11.001971Z] Finished read-buildbot-config step (success) 14:10:11 INFO - [mozharness: 2017-05-25 21:10:11.002194Z] Running download-and-extract step. 14:10:11 INFO - Running pre-action listener: _resource_record_pre_action 14:10:11 INFO - Running main action method: download_and_extract 14:10:11 INFO - mkdir: /builds/slave/test/build/tests 14:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:11 INFO - trying https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.test_packages.json 14:10:11 INFO - Downloading https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:10:11 INFO - Downloaded 986 bytes. 14:10:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:10:11 INFO - Using the following test package requirements: 14:10:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:10:11 INFO - u'common': [u'target.common.tests.zip'], 14:10:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:10:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:10:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:10:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:10:11 INFO - u'mozbase': [u'target.common.tests.zip'], 14:10:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:10:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:10:11 INFO - u'web-platform': [u'target.common.tests.zip', 14:10:11 INFO - u'target.web-platform.tests.zip'], 14:10:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:10:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:10:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.common.tests.zip 14:10:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:10:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.common.tests.zip into memory 14:10:13 INFO - Content-Length response header: 63524941 14:10:13 INFO - Bytes received: 63524941 14:10:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:10:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.common.tests.zip 14:10:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:10:24 INFO - Fetch https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.common.tests.zip into memory 14:10:25 INFO - Content-Length response header: 63524941 14:10:25 INFO - Bytes received: 63524941 14:10:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.talos.tests.zip 14:10:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:10:37 INFO - Fetch https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.talos.tests.zip into memory 14:10:38 INFO - Content-Length response header: 14411888 14:10:38 INFO - Bytes received: 14411888 14:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:38 INFO - trying https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.tar.bz2 14:10:38 INFO - Downloading https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:10:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:10:39 INFO - Downloaded 54025392 bytes. 14:10:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.tar.bz2 14:10:39 INFO - mkdir: /builds/slave/test/properties 14:10:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:10:39 INFO - Writing to file /builds/slave/test/properties/build_url 14:10:39 INFO - Contents: 14:10:39 INFO - build_url:https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.tar.bz2 14:10:39 INFO - Running post-action listener: _resource_record_post_action 14:10:39 INFO - Running post-action listener: set_extra_try_arguments 14:10:39 INFO - [mozharness: 2017-05-25 21:10:39.956304Z] Finished download-and-extract step (success) 14:10:39 INFO - [mozharness: 2017-05-25 21:10:39.956402Z] Running populate-webroot step. 14:10:39 INFO - Running pre-action listener: _resource_record_pre_action 14:10:39 INFO - Running main action method: populate_webroot 14:10:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:10:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:10:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:10:39 INFO - '--tppagecycles', 14:10:39 INFO - '7'], 14:10:39 INFO - 'tests': ['tsvgm']}}, 14:10:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:10:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:10:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:10:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:10:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:10:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:10:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:10:39 INFO - 'talos_options': ['--disable-e10s'], 14:10:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:10:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:10:39 INFO - 'talos_options': ['--disable-e10s'], 14:10:39 INFO - 'tests': ['damp', 'tps']}, 14:10:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:10:39 INFO - 'tests': ['damp', 'tps']}, 14:10:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:10:39 INFO - 'tests': ['dromaeo_dom']}, 14:10:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:10:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:10:39 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:10:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:10:39 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:10:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:10:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:10:39 INFO - 'tests': ['a11yr', 14:10:39 INFO - 'ts_paint', 14:10:39 INFO - 'tpaint', 14:10:39 INFO - 'sessionrestore', 14:10:39 INFO - 'sessionrestore_no_auto_restore', 14:10:39 INFO - 'tabpaint']}, 14:10:39 INFO - 'other-e10s': {'tests': ['a11yr', 14:10:39 INFO - 'ts_paint', 14:10:39 INFO - 'tpaint', 14:10:39 INFO - 'sessionrestore', 14:10:39 INFO - 'sessionrestore_no_auto_restore', 14:10:39 INFO - 'tabpaint']}, 14:10:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:10:39 INFO - 'ts_paint', 14:10:39 INFO - 'tpaint', 14:10:39 INFO - 'sessionrestore', 14:10:39 INFO - 'sessionrestore_no_auto_restore', 14:10:39 INFO - 'tabpaint']}, 14:10:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:10:39 INFO - 'ts_paint', 14:10:39 INFO - 'tpaint', 14:10:39 INFO - 'sessionrestore', 14:10:39 INFO - 'sessionrestore_no_auto_restore', 14:10:39 INFO - 'tabpaint']}, 14:10:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:10:39 INFO - 'tests': ['a11yr', 14:10:39 INFO - 'ts_paint', 14:10:39 INFO - 'tpaint', 14:10:39 INFO - 'sessionrestore', 14:10:39 INFO - 'sessionrestore_no_auto_restore', 14:10:39 INFO - 'tabpaint']}, 14:10:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:10:39 INFO - 'tests': ['a11yr', 14:10:39 INFO - 'ts_paint', 14:10:39 INFO - 'tpaint', 14:10:39 INFO - 'sessionrestore', 14:10:39 INFO - 'sessionrestore_no_auto_restore', 14:10:39 INFO - 'tabpaint']}, 14:10:39 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:10:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:10:39 INFO - 'bloom_basic_ref']}, 14:10:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:10:39 INFO - 'tests': ['tsvgx', 14:10:39 INFO - 'tsvgr_opacity', 14:10:39 INFO - 'tart', 14:10:39 INFO - 'tscrollx', 14:10:39 INFO - 'cart', 14:10:39 INFO - 'tsvg_static']}, 14:10:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:10:39 INFO - 'tsvgr_opacity', 14:10:39 INFO - 'tart', 14:10:39 INFO - 'tscrollx', 14:10:39 INFO - 'cart', 14:10:39 INFO - 'tsvg_static']}, 14:10:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:10:39 INFO - 'talos_options': ['--disable-e10s'], 14:10:39 INFO - 'tests': ['tp5o']}, 14:10:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:10:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:10:39 INFO - 'talos_options': ['--disable-e10s', 14:10:39 INFO - '--xperf_path', 14:10:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:39 INFO - 'tests': ['tp5n']}, 14:10:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:10:39 INFO - 'talos_options': ['--xperf_path', 14:10:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:39 INFO - 'tests': ['tp5n']}}, 14:10:39 INFO - 'talos.zip': {'path': '', 14:10:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:10:39 INFO - Running post-action listener: _resource_record_post_action 14:10:39 INFO - [mozharness: 2017-05-25 21:10:39.974863Z] Finished populate-webroot step (success) 14:10:39 INFO - [mozharness: 2017-05-25 21:10:39.974953Z] Running create-virtualenv step. 14:10:39 INFO - Running pre-action listener: _resource_record_pre_action 14:10:39 INFO - Running main action method: create_virtualenv 14:10:39 INFO - Creating virtualenv /builds/slave/test/build/venv 14:10:39 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:10:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:10:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:10:40 INFO - Using real prefix '/usr' 14:10:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:10:40 INFO - Installing distribute.............................................................................................................................................................................................done. 14:10:42 INFO - Installing pip.................done. 14:10:42 INFO - Return code: 0 14:10:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:10:42 INFO - Reading from file tmpfile_stdout 14:10:42 INFO - Output received: 14:10:42 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:10:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb7a0>, '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 0x1cfc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfcb30>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:10:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:10:42 INFO - Using env: {'DISPLAY': ':0', 14:10:42 INFO - 'HOME': '/home/cltbld', 14:10:42 INFO - 'LANG': 'en_US.UTF-8', 14:10:42 INFO - 'LANGUAGE': 'en_US:en', 14:10:42 INFO - 'LOGNAME': 'cltbld', 14:10:42 INFO - 'MAIL': '/var/mail/cltbld', 14:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:42 INFO - 'MOZ_NO_REMOTE': '1', 14:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:42 INFO - 'NO_EM_RESTART': '1', 14:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:42 INFO - 'PWD': '/builds/slave/test', 14:10:42 INFO - 'SHELL': '/bin/bash', 14:10:42 INFO - 'SHLVL': '1', 14:10:42 INFO - 'TERM': 'linux', 14:10:42 INFO - 'TMOUT': '86400', 14:10:42 INFO - 'USER': 'cltbld', 14:10:42 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 14:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:42 INFO - '_': '/tools/buildbot/bin/python'} 14:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:10:42 INFO - Cleaning up... 14:10:42 INFO - Return code: 0 14:10:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x198b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb7a0>, '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 0x1cfc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfcb30>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:10:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:10:42 INFO - Using env: {'DISPLAY': ':0', 14:10:42 INFO - 'HOME': '/home/cltbld', 14:10:42 INFO - 'LANG': 'en_US.UTF-8', 14:10:42 INFO - 'LANGUAGE': 'en_US:en', 14:10:42 INFO - 'LOGNAME': 'cltbld', 14:10:42 INFO - 'MAIL': '/var/mail/cltbld', 14:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:42 INFO - 'MOZ_NO_REMOTE': '1', 14:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:42 INFO - 'NO_EM_RESTART': '1', 14:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:42 INFO - 'PWD': '/builds/slave/test', 14:10:42 INFO - 'SHELL': '/bin/bash', 14:10:42 INFO - 'SHLVL': '1', 14:10:42 INFO - 'TERM': 'linux', 14:10:42 INFO - 'TMOUT': '86400', 14:10:42 INFO - 'USER': 'cltbld', 14:10:42 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 14:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:42 INFO - '_': '/tools/buildbot/bin/python'} 14:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:43 INFO - Downloading/unpacking psutil>=3.1.1 14:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:44 INFO - Installing collected packages: psutil 14:10:44 INFO - Running setup.py install for psutil 14:10:44 INFO - building 'psutil._psutil_linux' extension 14:10:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:10:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:10:44 INFO - building 'psutil._psutil_posix' extension 14:10:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:10:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:10:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:44 INFO - Successfully installed psutil 14:10:44 INFO - Cleaning up... 14:10:44 INFO - Return code: 0 14:10:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:44 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 0x198b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb7a0>, '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 0x1cfc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfcb30>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:10:44 INFO - Using env: {'DISPLAY': ':0', 14:10:44 INFO - 'HOME': '/home/cltbld', 14:10:44 INFO - 'LANG': 'en_US.UTF-8', 14:10:44 INFO - 'LANGUAGE': 'en_US:en', 14:10:44 INFO - 'LOGNAME': 'cltbld', 14:10:44 INFO - 'MAIL': '/var/mail/cltbld', 14:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:44 INFO - 'MOZ_NO_REMOTE': '1', 14:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:44 INFO - 'NO_EM_RESTART': '1', 14:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:44 INFO - 'PWD': '/builds/slave/test', 14:10:44 INFO - 'SHELL': '/bin/bash', 14:10:44 INFO - 'SHLVL': '1', 14:10:44 INFO - 'TERM': 'linux', 14:10:44 INFO - 'TMOUT': '86400', 14:10:44 INFO - 'USER': 'cltbld', 14:10:44 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 14:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:44 INFO - '_': '/tools/buildbot/bin/python'} 14:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:10:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:10:46 INFO - Installing collected packages: mozsystemmonitor 14:10:46 INFO - Running setup.py install for mozsystemmonitor 14:10:46 INFO - Successfully installed mozsystemmonitor 14:10:46 INFO - Cleaning up... 14:10:46 INFO - Return code: 0 14:10:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x198b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb7a0>, '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 0x1cfc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfcb30>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:10:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:10:46 INFO - Using env: {'DISPLAY': ':0', 14:10:46 INFO - 'HOME': '/home/cltbld', 14:10:46 INFO - 'LANG': 'en_US.UTF-8', 14:10:46 INFO - 'LANGUAGE': 'en_US:en', 14:10:46 INFO - 'LOGNAME': 'cltbld', 14:10:46 INFO - 'MAIL': '/var/mail/cltbld', 14:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:46 INFO - 'MOZ_NO_REMOTE': '1', 14:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:46 INFO - 'NO_EM_RESTART': '1', 14:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:46 INFO - 'PWD': '/builds/slave/test', 14:10:46 INFO - 'SHELL': '/bin/bash', 14:10:46 INFO - 'SHLVL': '1', 14:10:46 INFO - 'TERM': 'linux', 14:10:46 INFO - 'TMOUT': '86400', 14:10:46 INFO - 'USER': 'cltbld', 14:10:46 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 14:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:46 INFO - '_': '/tools/buildbot/bin/python'} 14:10:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:46 INFO - Downloading/unpacking jsonschema==2.5.1 14:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:10:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:47 INFO - Downloading functools32-3.2.3-2.tar.gz 14:10:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:10:47 INFO - warning: no files found matching '*.txt' 14:10:47 INFO - no previously-included directories found matching 'build' 14:10:47 INFO - no previously-included directories found matching 'dist' 14:10:47 INFO - no previously-included directories found matching '.git*' 14:10:47 INFO - Installing collected packages: jsonschema, functools32 14:10:47 INFO - Running setup.py install for functools32 14:10:48 INFO - warning: no files found matching '*.txt' 14:10:48 INFO - no previously-included directories found matching 'build' 14:10:48 INFO - no previously-included directories found matching 'dist' 14:10:48 INFO - no previously-included directories found matching '.git*' 14:10:48 INFO - Successfully installed jsonschema functools32 14:10:48 INFO - Cleaning up... 14:10:48 INFO - Return code: 0 14:10:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:48 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 0x198b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb7a0>, '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 0x1cfc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfcb30>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:10:48 INFO - Using env: {'DISPLAY': ':0', 14:10:48 INFO - 'HOME': '/home/cltbld', 14:10:48 INFO - 'LANG': 'en_US.UTF-8', 14:10:48 INFO - 'LANGUAGE': 'en_US:en', 14:10:48 INFO - 'LOGNAME': 'cltbld', 14:10:48 INFO - 'MAIL': '/var/mail/cltbld', 14:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:48 INFO - 'MOZ_NO_REMOTE': '1', 14:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:48 INFO - 'NO_EM_RESTART': '1', 14:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:48 INFO - 'PWD': '/builds/slave/test', 14:10:48 INFO - 'SHELL': '/bin/bash', 14:10:48 INFO - 'SHLVL': '1', 14:10:48 INFO - 'TERM': 'linux', 14:10:48 INFO - 'TMOUT': '86400', 14:10:48 INFO - 'USER': 'cltbld', 14:10:48 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 14:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:48 INFO - '_': '/tools/buildbot/bin/python'} 14:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:10:48 INFO - Cleaning up... 14:10:48 INFO - Return code: 0 14:10:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:48 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 0x198b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb7a0>, '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 0x1cfc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfcb30>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:10:48 INFO - Using env: {'DISPLAY': ':0', 14:10:48 INFO - 'HOME': '/home/cltbld', 14:10:48 INFO - 'LANG': 'en_US.UTF-8', 14:10:48 INFO - 'LANGUAGE': 'en_US:en', 14:10:48 INFO - 'LOGNAME': 'cltbld', 14:10:48 INFO - 'MAIL': '/var/mail/cltbld', 14:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:48 INFO - 'MOZ_NO_REMOTE': '1', 14:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:48 INFO - 'NO_EM_RESTART': '1', 14:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:48 INFO - 'PWD': '/builds/slave/test', 14:10:48 INFO - 'SHELL': '/bin/bash', 14:10:48 INFO - 'SHLVL': '1', 14:10:48 INFO - 'TERM': 'linux', 14:10:48 INFO - 'TMOUT': '86400', 14:10:48 INFO - 'USER': 'cltbld', 14:10:48 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 14:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:48 INFO - '_': '/tools/buildbot/bin/python'} 14:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:48 INFO - Downloading/unpacking blobuploader==1.2.4 14:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:49 INFO - Downloading blobuploader-1.2.4.tar.gz 14:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:10:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:10:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:50 INFO - Downloading docopt-0.6.1.tar.gz 14:10:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:10:50 INFO - Installing collected packages: blobuploader, requests, docopt 14:10:50 INFO - Running setup.py install for blobuploader 14:10:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:10:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:10:50 INFO - Running setup.py install for requests 14:10:50 INFO - Running setup.py install for docopt 14:10:50 INFO - Successfully installed blobuploader requests docopt 14:10:50 INFO - Cleaning up... 14:10:50 INFO - Return code: 0 14:10:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:50 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 0x198b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb7a0>, '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 0x1cfc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfcb30>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:10:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:10:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:10:50 INFO - Using env: {'DISPLAY': ':0', 14:10:50 INFO - 'HOME': '/home/cltbld', 14:10:50 INFO - 'LANG': 'en_US.UTF-8', 14:10:50 INFO - 'LANGUAGE': 'en_US:en', 14:10:50 INFO - 'LOGNAME': 'cltbld', 14:10:50 INFO - 'MAIL': '/var/mail/cltbld', 14:10:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:50 INFO - 'MOZ_NO_REMOTE': '1', 14:10:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:50 INFO - 'NO_EM_RESTART': '1', 14:10:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:50 INFO - 'PWD': '/builds/slave/test', 14:10:50 INFO - 'SHELL': '/bin/bash', 14:10:50 INFO - 'SHLVL': '1', 14:10:50 INFO - 'TERM': 'linux', 14:10:50 INFO - 'TMOUT': '86400', 14:10:50 INFO - 'USER': 'cltbld', 14:10:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 14:10:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:50 INFO - '_': '/tools/buildbot/bin/python'} 14:10:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:50 INFO - Running setup.py (path:/tmp/pip-beF5Fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:51 INFO - Running setup.py (path:/tmp/pip-ObYzY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:51 INFO - Running setup.py (path:/tmp/pip-NTeV9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:51 INFO - Running setup.py (path:/tmp/pip-AVIdRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:51 INFO - Running setup.py (path:/tmp/pip-DHQbsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:51 INFO - Running setup.py (path:/tmp/pip-5365EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:51 INFO - Running setup.py (path:/tmp/pip-ZKBNXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:51 INFO - Running setup.py (path:/tmp/pip-_Pb8HM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:51 INFO - Running setup.py (path:/tmp/pip-y4Z4wq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:51 INFO - Running setup.py (path:/tmp/pip-UJyvwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:51 INFO - Running setup.py (path:/tmp/pip-hPF9Yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:51 INFO - Running setup.py (path:/tmp/pip-Z2rv1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:51 INFO - Running setup.py (path:/tmp/pip-ihVyG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:51 INFO - Running setup.py (path:/tmp/pip-vwWoqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:51 INFO - Running setup.py (path:/tmp/pip-FKBIMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:52 INFO - Running setup.py (path:/tmp/pip-K9Oru4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:52 INFO - Running setup.py (path:/tmp/pip-_QsZ2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:10:52 INFO - Running setup.py install for manifestparser 14:10:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Running setup.py install for mozcrash 14:10:52 INFO - Running setup.py install for mozdebug 14:10:52 INFO - Running setup.py install for mozdevice 14:10:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Running setup.py install for mozfile 14:10:52 INFO - Running setup.py install for mozhttpd 14:10:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Running setup.py install for mozinfo 14:10:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Running setup.py install for mozInstall 14:10:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:10:52 INFO - Running setup.py install for mozleak 14:10:53 INFO - Running setup.py install for mozlog 14:10:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:10:53 INFO - Running setup.py install for moznetwork 14:10:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:10:53 INFO - Running setup.py install for mozprocess 14:10:53 INFO - Running setup.py install for mozprofile 14:10:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:10:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:10:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:10:53 INFO - Running setup.py install for mozrunner 14:10:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:10:53 INFO - Running setup.py install for mozscreenshot 14:10:53 INFO - Running setup.py install for moztest 14:10:53 INFO - Running setup.py install for mozversion 14:10:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:10:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:10:53 INFO - Cleaning up... 14:10:53 INFO - Return code: 0 14:10:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:53 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 0x198b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb7a0>, '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 0x1cfc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfcb30>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:10:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:10:53 INFO - Using env: {'DISPLAY': ':0', 14:10:53 INFO - 'HOME': '/home/cltbld', 14:10:53 INFO - 'LANG': 'en_US.UTF-8', 14:10:53 INFO - 'LANGUAGE': 'en_US:en', 14:10:53 INFO - 'LOGNAME': 'cltbld', 14:10:53 INFO - 'MAIL': '/var/mail/cltbld', 14:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:53 INFO - 'MOZ_NO_REMOTE': '1', 14:10:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:53 INFO - 'NO_EM_RESTART': '1', 14:10:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:53 INFO - 'PWD': '/builds/slave/test', 14:10:53 INFO - 'SHELL': '/bin/bash', 14:10:53 INFO - 'SHLVL': '1', 14:10:53 INFO - 'TERM': 'linux', 14:10:53 INFO - 'TMOUT': '86400', 14:10:53 INFO - 'USER': 'cltbld', 14:10:53 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 14:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:53 INFO - '_': '/tools/buildbot/bin/python'} 14:10:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:54 INFO - Running setup.py (path:/tmp/pip-6DUSNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:54 INFO - Running setup.py (path:/tmp/pip-PftGHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:54 INFO - Running setup.py (path:/tmp/pip-dEp91S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:54 INFO - Running setup.py (path:/tmp/pip-i6H12s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:54 INFO - Running setup.py (path:/tmp/pip-tH_vdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:54 INFO - Running setup.py (path:/tmp/pip-hf7PW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:54 INFO - Running setup.py (path:/tmp/pip-JxGVsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:54 INFO - Running setup.py (path:/tmp/pip-DhLhWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:54 INFO - Running setup.py (path:/tmp/pip-cOXvMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:54 INFO - Running setup.py (path:/tmp/pip-hK8Dhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:54 INFO - Running setup.py (path:/tmp/pip-jIcqOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:10:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:55 INFO - Running setup.py (path:/tmp/pip-tfgqiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:55 INFO - Running setup.py (path:/tmp/pip-FPwqnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:55 INFO - Running setup.py (path:/tmp/pip-RCRg05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:55 INFO - Running setup.py (path:/tmp/pip-JCIwkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:55 INFO - Running setup.py (path:/tmp/pip-_eW4PG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:10:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:55 INFO - Running setup.py (path:/tmp/pip-A3gDXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:10:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:10:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:56 INFO - Downloading blessings-1.6.tar.gz 14:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:10:56 INFO - Installing collected packages: blessings 14:10:56 INFO - Running setup.py install for blessings 14:10:56 INFO - Successfully installed blessings 14:10:56 INFO - Cleaning up... 14:10:56 INFO - Return code: 0 14:10:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:10:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:56 INFO - Reading from file tmpfile_stdout 14:10:56 INFO - Current package versions: 14:10:56 INFO - argparse == 1.2.1 14:10:56 INFO - blessings == 1.6 14:10:56 INFO - blobuploader == 1.2.4 14:10:56 INFO - docopt == 0.6.1 14:10:56 INFO - functools32 == 3.2.3-2 14:10:56 INFO - jsonschema == 2.5.1 14:10:56 INFO - manifestparser == 1.1 14:10:56 INFO - mozInstall == 1.12 14:10:56 INFO - mozcrash == 1.0 14:10:56 INFO - mozdebug == 0.1 14:10:56 INFO - mozdevice == 0.51 14:10:56 INFO - mozfile == 1.2 14:10:56 INFO - mozhttpd == 0.7 14:10:56 INFO - mozinfo == 0.9 14:10:56 INFO - mozleak == 0.1 14:10:56 INFO - mozlog == 3.4 14:10:56 INFO - moznetwork == 0.27 14:10:56 INFO - mozprocess == 0.25 14:10:56 INFO - mozprofile == 0.28 14:10:56 INFO - mozrunner == 6.13 14:10:56 INFO - mozscreenshot == 0.1 14:10:56 INFO - mozsystemmonitor == 0.3 14:10:56 INFO - moztest == 0.8 14:10:56 INFO - mozversion == 1.4 14:10:56 INFO - psutil == 3.1.1 14:10:56 INFO - requests == 1.2.3 14:10:56 INFO - wsgiref == 0.1.2 14:10:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:56 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 0x198b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb7a0>, '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 0x1cfc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfcb30>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:10:56 INFO - Using env: {'DISPLAY': ':0', 14:10:56 INFO - 'HOME': '/home/cltbld', 14:10:56 INFO - 'LANG': 'en_US.UTF-8', 14:10:56 INFO - 'LANGUAGE': 'en_US:en', 14:10:56 INFO - 'LOGNAME': 'cltbld', 14:10:56 INFO - 'MAIL': '/var/mail/cltbld', 14:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:56 INFO - 'MOZ_NO_REMOTE': '1', 14:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:56 INFO - 'NO_EM_RESTART': '1', 14:10:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:56 INFO - 'PWD': '/builds/slave/test', 14:10:56 INFO - 'SHELL': '/bin/bash', 14:10:56 INFO - 'SHLVL': '1', 14:10:56 INFO - 'TERM': 'linux', 14:10:56 INFO - 'TMOUT': '86400', 14:10:56 INFO - 'USER': 'cltbld', 14:10:56 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 14:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:56 INFO - '_': '/tools/buildbot/bin/python'} 14:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:10:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:10:57 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:10:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:10:58 INFO - Downloading marionette_driver-1.4.0.tar.gz 14:10:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 14:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:10:58 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)) 14:10:58 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)) 14:10:58 INFO - Installing collected packages: marionette-driver 14:10:58 INFO - Running setup.py install for marionette-driver 14:10:58 INFO - Successfully installed marionette-driver 14:10:58 INFO - Cleaning up... 14:10:58 INFO - Return code: 0 14:10:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:58 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 0x198b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b58a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfe5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb7a0>, '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 0x1cfc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfcb30>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:10:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:10:58 INFO - Using env: {'DISPLAY': ':0', 14:10:58 INFO - 'HOME': '/home/cltbld', 14:10:58 INFO - 'LANG': 'en_US.UTF-8', 14:10:58 INFO - 'LANGUAGE': 'en_US:en', 14:10:58 INFO - 'LOGNAME': 'cltbld', 14:10:58 INFO - 'MAIL': '/var/mail/cltbld', 14:10:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:58 INFO - 'MOZ_NO_REMOTE': '1', 14:10:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:58 INFO - 'NO_EM_RESTART': '1', 14:10:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:58 INFO - 'PWD': '/builds/slave/test', 14:10:58 INFO - 'SHELL': '/bin/bash', 14:10:58 INFO - 'SHLVL': '1', 14:10:58 INFO - 'TERM': 'linux', 14:10:58 INFO - 'TMOUT': '86400', 14:10:58 INFO - 'USER': 'cltbld', 14:10:58 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 14:10:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:58 INFO - '_': '/tools/buildbot/bin/python'} 14:10:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:10:58 INFO - Cleaning up... 14:10:58 INFO - Return code: 0 14:10:58 INFO - Running post-action listener: _resource_record_post_action 14:10:58 INFO - Running post-action listener: _start_resource_monitoring 14:10:58 INFO - Starting resource monitoring. 14:10:58 INFO - [mozharness: 2017-05-25 21:10:58.773125Z] Finished create-virtualenv step (success) 14:10:58 INFO - [mozharness: 2017-05-25 21:10:58.773695Z] Running install step. 14:10:58 INFO - Running pre-action listener: _resource_record_pre_action 14:10:58 INFO - Running main action method: install 14:10:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:58 INFO - Reading from file tmpfile_stdout 14:10:58 INFO - Detecting whether we're running mozinstall >=1.0... 14:10:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:10:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:10:59 INFO - Reading from file tmpfile_stdout 14:10:59 INFO - Output received: 14:10:59 INFO - Usage: mozinstall [options] installer 14:10:59 INFO - Options: 14:10:59 INFO - -h, --help show this help message and exit 14:10:59 INFO - -d DEST, --destination=DEST 14:10:59 INFO - Directory to install application into. [default: 14:10:59 INFO - "/builds/slave/test"] 14:10:59 INFO - --app=APP Application being installed. [default: firefox] 14:10:59 INFO - mkdir: /builds/slave/test/build/application 14:10:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:10:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:11:14 INFO - Reading from file tmpfile_stdout 14:11:14 INFO - Output received: 14:11:14 INFO - /builds/slave/test/build/application/firefox/firefox 14:11:14 INFO - Running post-action listener: _resource_record_post_action 14:11:14 INFO - [mozharness: 2017-05-25 21:11:14.858133Z] Finished install step (success) 14:11:14 INFO - [mozharness: 2017-05-25 21:11:14.858413Z] Running run-tests step. 14:11:14 INFO - Running pre-action listener: _resource_record_pre_action 14:11:14 INFO - Running main action method: run_tests 14:11:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:11:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:11:14 INFO - Python 2.7.3 14:11:14 INFO - Return code: 0 14:11:14 INFO - grabbing minidump binary from tooltool 14:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:11:14 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 0x1cfb7a0>, '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 0x1cfc6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfcb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:11:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:11:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:11:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:11:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:14 INFO - Return code: 0 14:11:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:11:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:11:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:11:14 INFO - ENV: RUST_BACKTRACE is now 1 14:11:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:11:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:11:14 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/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:11:14 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/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-033 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:11:14 INFO - Using env: {'DISPLAY': ':0', 14:11:14 INFO - 'HOME': '/home/cltbld', 14:11:14 INFO - 'LANG': 'en_US.UTF-8', 14:11:14 INFO - 'LANGUAGE': 'en_US:en', 14:11:14 INFO - 'LOGNAME': 'cltbld', 14:11:14 INFO - 'MAIL': '/var/mail/cltbld', 14:11:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:11:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:14 INFO - 'MOZ_NO_REMOTE': '1', 14:11:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:11:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:14 INFO - 'NO_EM_RESTART': '1', 14:11:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:14 INFO - 'PWD': '/builds/slave/test', 14:11:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:11:14 INFO - 'RUST_BACKTRACE': '1', 14:11:14 INFO - 'SHELL': '/bin/bash', 14:11:14 INFO - 'SHLVL': '1', 14:11:14 INFO - 'TERM': 'linux', 14:11:14 INFO - 'TMOUT': '86400', 14:11:14 INFO - 'USER': 'cltbld', 14:11:14 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537', 14:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:14 INFO - '_': '/tools/buildbot/bin/python'} 14:11:14 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/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:11:15 INFO - mozversion application_buildid: 20170525203208 14:11:15 INFO - mozversion application_changeset: bdf2d1918fb0b434ab8782d003afbe3f9639cd45 14:11:15 INFO - mozversion application_display_name: Nightly 14:11:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:15 INFO - mozversion application_name: Firefox 14:11:15 INFO - mozversion application_remotingname: firefox 14:11:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:11:15 INFO - mozversion application_vendor: Mozilla 14:11:15 INFO - mozversion application_version: 55.0a1 14:11:15 INFO - mozversion platform_buildid: 20170525203208 14:11:15 INFO - mozversion platform_changeset: bdf2d1918fb0b434ab8782d003afbe3f9639cd45 14:11:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:11:15 INFO - mozversion platform_version: 55.0a1 14:11:15 INFO - using testdate: 1495746675 14:11:15 INFO - actual date: 1495746675 14:11:15 INFO - starting webserver on 'localhost:52837' 14:11:15 INFO - SUITE-START | Running 2 tests 14:11:15 INFO - TEST-START | dromaeo_css 14:11:15 INFO - operating with platform_type : linux_ 14:11:15 INFO - Initialising browser for dromaeo_css test... 14:11:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52837/getInfo.html -profile /tmp/tmpox_BFp/profile 14:11:15 INFO - TEST-INFO | started process 11939 (/builds/slave/test/build/application/firefox/firefox http://localhost:52837/getInfo.html) 14:11:50 INFO - TEST-INFO | 11939: killed by SIGTERM 14:11:50 INFO - Browser initialized. 14:11:50 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:50 INFO - TEST-INFO | started process 12138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpox_BFp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:02 INFO - PID 12138 | RSS: Main: 168009728 14:12:02 INFO - PID 12138 | 14:15:07 INFO - PID 12138 | Cycle 1(1): loaded http://localhost:52837/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52837/tests/dromaeo/cssquery-ext.html) 14:15:08 INFO - PID 12138 | RSS: Main: 166162432 14:15:08 INFO - PID 12138 | 14:18:10 INFO - PID 12138 | Cycle 1(1): loaded http://localhost:52837/tests/dromaeo/cssquery-ext.html (next: http://localhost:52837/tests/dromaeo/cssquery-jquery.html) 14:18:11 INFO - PID 12138 | RSS: Main: 172232704 14:18:11 INFO - PID 12138 | 14:21:13 INFO - PID 12138 | Cycle 1(1): loaded http://localhost:52837/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52837/tests/dromaeo/cssquery-mootools.html) 14:21:13 INFO - PID 12138 | RSS: Main: 169385984 14:21:13 INFO - PID 12138 | 14:24:15 INFO - PID 12138 | Cycle 1(1): loaded http://localhost:52837/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52837/tests/dromaeo/cssquery-prototype.html) 14:24:16 INFO - PID 12138 | RSS: Main: 174694400 14:24:16 INFO - PID 12138 | 14:27:18 INFO - PID 12138 | Cycle 1(1): loaded http://localhost:52837/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52837/tests/dromaeo/cssquery-yui.html) 14:27:19 INFO - PID 12138 | RSS: Main: 173109248 14:27:19 INFO - PID 12138 | 14:30:21 INFO - PID 12138 | Cycle 1(1): loaded http://localhost:52837/tests/dromaeo/cssquery-yui.html (next: http://localhost:52837/tests/dromaeo/cssquery-dojo.html) 14:30:21 INFO - PID 12138 | RSS: Main: 170704896 14:30:21 INFO - PID 12138 | 14:30:21 INFO - PID 12138 | __start_tp_report 14:30:21 INFO - PID 12138 | _x_x_mozilla_page_load 14:30:21 INFO - PID 12138 | _x_x_mozilla_page_load_details 14:30:21 INFO - PID 12138 | |i|pagename|runs| 14:30:21 INFO - PID 12138 | |0;dojo.html;2720.537508623534;2725.5230334691423;2735.0837469447733;2735.398212393273;2761.779057675385;5105.795768169278;5212.322398088253;5213;5219.634625576206;5269.262303277539;5208.661437006592;5211.557017653495;5235.633505654606;5303.284056652351;5313.814016509423;4441.7044216321565;4597.862064138065;4636.09596128755;4657.32468792025;4667.649926255544;4698.271767875985;4716.646251531131;4728.763561821912;4736.573708366246;4771.570558649721;4554.4990051094355;4605.078984203173;4659.254519276899;4663.067386522675;4678.204705200124;4663.323818046364;4668.6731928765;4671.532846715335;4699.506551812045;4707.223308154151;4618.861434156981;4622.6301895848255;4630.259158534618;4634.86095417138;4690.249560070407;5139;5180.093483640348;5202.193659982709;5210.947890521122;5260.921086183672;5667.206591077253;5677.829665110054;5693.28833895763;5713.342965558931;5731.111677689923;5684.062129748587;5715.571332150105;5720.885582288331;5721.9427805721825;5724.084146536576;5199.376074871039;5280.891012887259;5297.073012222845;5304.734763261821;5305.389880163753;5774.451427114417;5850.5027072699295;5855.268091488564;5863.472287494146;5865.589408741347;5453.263809385682;5514.696691681916;5520.861978450571;5524.171374293888;5527.861803454945;5612.045952188138;5640.689762063043;5678.914816277759;5700.657960522382;5723.055695810228;5629.268195134607;5632.436756324417;5633.464820842013;5639.295088113986;5643.887122257532;5466.262054622654;5514.145307477347;5564.221009058735;5623.072193088176;5647.971760141173;4656.511066338054;4697.436307643105;4718.622510199176;4722.858314250578;4735.147673418817;4030.9596904030586;4045.8786236412957;4052;4111.177764447122;4130.091379896418;4790.377250957354;4791.856244312677;4791.976040119777;4827.61379089672;4829.106615276185;5494.1758736189095;5543.695096769717;5592.720363981784;5674.120511320752;5675.517581005661;4793.18515852306;4795.832145874878;4801.7118972861745;4819.325294458778;4840.975795121002;5007.4491805901325;5018.89962200754;5022.547970682656;5032.748362581856;5073.695578265316;5191.740412979411;5266.710330931835;5272.0773864572775;5277.656952298012;5285.68285902847;5626.324841019104;5692.658440493418;5693.4875861172695;5706.543476521785;5712.11462223356;5227.18978558324;5239.05696974533;5239.08316044683;5248;5283.603729720363;5544.861378465571;5550.47270509301;5550.55595552363;5556.638818476786;5604.103343465026;5566.165075238585;5635.774569017193;5658.745356458887;5724.284464441945;5749.396313387034;5388.434214407431;5477.4248703887115;5481.561475082063;5483.150111732688;5528.668279903219;5436.9456305438025;5480.260164877691;5540.778368865362;5554.2779438672715;5566.777328906798;5318.468153184651;5369.221462887937;5424.755885985219;5430.972845135749;5435;5483.8080667176455;5529.557635389078;5534.1975413565615;5548.056830338933;5549.889002219852;5322.148456246982;5366.946330536644;5376.112941364788;5380.838574842761;5387.919181212364 14:30:21 INFO - PID 12138 | |1;ext.html;634.3181080338637;678.684411748537;690.9861802763943;1175.371176420615;1225.166886517168;35344.646553534454;36333.45499817502;36379.27241455173;36443;36496.635033649654;34504.30991380177;34924.65075349246;34972.300553988905;35001.474977875354;35196;6534.411902928748;6704.329567043281;6710.932890671104;6720.83197920051;6722.1261236039245;6838.11104556407;6915.377616014558;6941.444684425234;6945.201301850276;6953.061336719554;6911.5853048817235;6939.653017349137;6970.337817907316;6971.093757811503;6984.720611175547;6913.861722765541;6942.687579058955;6949.3745562899585;6951.0616066830835;6954.40887524561;6747.122874026345;6800.557963732391;6806.489513286523;6816.284290149512;6819.727210911557;33128.17179570506;33300.1674958128;33358.33283334344;33380.499292510634;33413.665863341295;2954.4534261161753;2972.3609423973735;2983.820970741741;2986.566947792558;3000;24956.875215623804;25145;25209.369765756004;25209.873950630314;25233.49533009348;2992.07245753817;3001.654809696891;3015.522394026933;3050.4051709916575;3062.0507642630855;148285;150325;150670;151399;153620.9999999989;39425.60574394277;39599.20801583952;39852.60147398489;39985.80007100004;40061.39907901384;41865.37201941973;42064.579354206675;42183.36724949128;48004.5199548;48379.27431088537;13323.067385282937;13341.93329033368;13440.798388024188;13462.932685336707;13519.797203041962;10669.146468282674;10719.303245289031;10749.62376316825;10793.892061079288;10816.351018938889;13168.209907405586;13191.340432978313;13257.337133143305;13303.135296205715;13494.865051349361;5495.862603434946;5499.340079190522;5605.579581531401;5704.315482142087;5711.086226203871;871.7079778274223;904.4347282948157;913.5569248914271;915.1443400420628;945.4280160502934;20966.79033209679;21877.453063673536;21941.780582193973;21961.121555137936;22273.66589501159;971.7182017214928;974.3763991045737;976.6044751875502;990.7721224118493;1003.3528374198601;11349;11496.942515287537;11496.942515287537;11522.654320370235;11576.94211528937;180645;181078;182358;183242;183332;41557.584424155975;42076.15847683029;42197.578024219365;42352.36471452931;42407.151856962686;1197.126097948485;1240.138104017717;1243.9315837628835;1244.6141696074064;1251.8122281657825;19664.901675492103;19958.30145944885;20440;21474.14103435845;21578.136874524844;30112.548311774903;30439.695603043685;30494.542581861733;30645.23386915345;30662.386752265276;149075.25462372618;150918;151151;151304;152124;30638.693613063584;30847.69152308538;30967;30992.53511197379;31012.844935775178;36591.08522286964;36655.63344366629;36717.44923826091;37096.443553347264;37216.25567488581;25840.8707956459;26921.326966825985;27213;27895.442091158468;28331.858340708164;26491.60262596024;26961.73038269592;27035.459290814466;27820;28312.85843570769;30918.0724578263;30951;31245.531317029807;31283.687163128987;31316;25621.615675764504;26524.469510610066;26850.462990740467;27183.320416989733;27529.86235068812;20050.799492004895;22075.779242208017;22161.445963850387;22290.442738931655;22354.888225558767 14:30:21 INFO - PID 12138 | |2;jquery.html;401.2016087984909;407.9938800917985;415.81496234175785;416.25282617701225;431.4326660441519;15114.697706045872;16124.516264512054;17110.144492775373;17904.82095179048;17996.820031799678;17873.10634468278;18557.257709691596;18619.813801862012;19112.42662720117;19652;5329.573634109282;5491.780328786844;5606.55147588194;5622.381538030813;5624.775008999635;5175.197844334115;5320.255164276985;5323.520883120518;5342.732863356836;5346.705931173784;5062.139436295838;5301.5228629423345;5314.3091398118195;5320.600954928376;5331.6267861249535;5269.499397557226;5270.604704647148;5295.708736019517;5305.920411193816;5310.840674779763;4778.80884764609;4807.42310922688;4892.584130348924;4909.263610458424;4919.827806026772;22744.54510909789;22811.657825132635;22931.312060638207;22957.885210574008;23051.193208237797;1633.6977659132979;1635.1497221444902;1660.3524625396105;1667.6164482169047;1672.9414470493596;14381.64045898861;14426.134431934117;14849.628759280997;14913.627159320995;14932.50674932509;1984;2002.3192114680933;2030.2792508659509;2044.3866839947957;2049.477383267272;93335.99999999932;94980;95747;95868;96173;10850;11010.669679909615;11067.50196241171;11089.451375559744;11261.774764504664;15546.413807926463;15576.688466230611;15588.688226235412;15590.376384944475;15591.844081559038;7672.578008209602;7730.458867879307;7878.094019187867;7893.368530517545;7933.801654958556;7145.499815013003;7161.391281741006;7180.640967951582;7380.483366164317;7381.151167615685;6922;6947.756828510978;7037.859242815115;7070.646467676595;7117.679704413314;2000.6298834715624;2012.6679097948968;2027.9188832446537;2033.5526184239739;2108.5134979839177;806.7539400482792;863.5845232107001;875.5622188905547;890.0298674444886;890.7550423633423;17228.397006104726;17515.912420437817;17604.207810648553;17796.46610601684;18159.182836772114;862.2929198057533;862.6808081010066;864.8789169516273;865.4288169807896;890.5680744838749;9185.402948808307;9373.953130234442;9675.467849268218;9688.564014619358;9749.07383798538;351326;355071;357125;359404;363492;79517;80859;80994;81986.59006704928;82797.17202827895;1052.578968412641;1058.6771034834449;1073.3398959639921;1075.3279200499687;1078.9352638841694;14476.276186190858;14636.121832690073;14643.26783660834;14757.704845903236;15370.769438458656;38089.809550952064;38830.805845970586;39408.80295598504;39807;39950.40074398944;49169.50830491649;49281.26078108903;50891.49108509016;51001.23498147605;52009.21986170135;7952.522848629101;7982.321502672338;7984.24149705777;8044.517328960281;8092.797680058045;12736.968897285706;12854.421551030413;12884.677883052624;13027.869721302666;13064.80402793978;10427.843582346422;10679.305845120043;10782.568697252022;10914.50884710174;10929.726756830825;9462.479563624067;9707.951460242653;9880.901190988287;10029.297949143782;10070.798584028133;11127.944360278147;11180.720481988015;11378.43107844621;11543.711407214887;11693.532258709556;7976.322012628992;8220.506769593843;8339.624716887633;8436.24073833358;8443.155684431753;11124.443777811239;11656.88343116558;11863;11937.970545007196;12114.697132571757 14:30:21 INFO - PID 12138 | |3;mootools.html;1278.552506622682;1325.6553296143;1345.1122259308852;1346.1384713783175;1346.4143097752478;10465.68602941912;10934.070603998649;10941.015308622222;10969.561217551289;11247.887521124787;11018.669439916815;11164.609238676649;11168.497417616207;11187.720306992329;11240.606578769744;2151.870887746736;2184.4975655599224;2185.344396680989;2199.461132022657;2203.0416768705663;2207.227470385368;2221.8777967211795;2229.27231395668;2239.529698763262;2255.4135924659627;2148.699182114505;2196.5826492966366;2203.3720389688942;2213.302809614974;2217.2572188316935;2130.275706259871;2138.3050508584774;2140.6039882621685;2142.37871017404;2151.655735082379;2029.0564887327464;2070.4616799632054;2108.3569511299047;2198.208644887839;2199.681046248301;10756.139508839353;10832.891671083267;10840.078593319577;10854;10900.945495272552;5519.337679478448;5710;5728.398518155617;5733.369329373765;5740.655560666373;3273.116258610186;3412.8805491807916;3465.3069386122875;3474.5483087198504;3478.5477887874413;1001.324106228293;1020.1023099672315;1025.354026963016;1070.138538476526;1084.4740300954031;16257.593560160973;16315;16339.101349425777;16360.918195408947;16404.917975410284;4619.514950930171;4802.759862006886;4918.0901533216465;4920.6801557898625;4933.580645645088;11328.150388720878;11421.143414243965;11422.914823091793;11442.94278528602;11456.369899655432;5503.11950087992;5589.804356847572;5604.103343465026;5612.130119831432;5619.971900140473;5145.4854514549;5172.27588137661;5178.948210517847;5196.45437229093;5208.6874787512115;3911.6283953024417;3919.8236079375924;4013.2976729072298;4043.130726893732;4049.1091959768805;1110.8167152419921;1122.7586068995042;1134.3987686526154;1138.6242539961793;1142.9085673146128;717.989230161548;743.5724458436421;752.9623518824037;759.7189040055215;763.3320844261272;5870.911936320958;6111.5110791137495;6232.065190221412;7025.473089518307;7075.2217256101785;844.6072576252072;856.6873091321747;869.4956924983494;872.6247713483136;896.0457113174448;3845.1540661054523;4067.9796601016806;4179.561146079618;4377.299632058855;4692.319613656001;13893.58319250424;14339.78490322646;14369.928150359181;14371.568852934428;14373.28133593337;13926.234057126956;13982.930085349508;14574.635634109232;14720.19038952868;14767.187804670846;7274.418046556369;7563.054618172839;7789.571573563395;7942.602869856484;8006.919930800734;6317.9052314214405;6469.256035555972;6476.546641735222;6679.799606011828;6782.491313151632;12173.939130304292;12223.266604003788;12543;12620.55828046014;12814.743705125658;12913.079284270496;12922.353882305659;12942.417591208607;13128.277944713132;13164.670883227996;9714.95142524311;10012.549435275285;10060.396376217157;10060.798784024424;10089.243306751876;10138.239632027775;10162.136218421518;10172.593096276361;10180.185585153022;10221.23340749432;7957.482763620577;7961.283484486424;8054;8748.868766968628;8944.239739622206;7879.566623835744;8055.073666528424;8440.198181172778;8512.148785121439;8698.956505217433;7452.105747310357;7608.8478230436185;7717.575533345495;7747.883781743166;7771.805704857424;5516.393196748435;5572.3034620672415;5579.330480342385;5649.661020338793;5705.743241554057;5722.4277572242445;5818.796342128175;5895.380984996686;5925.555583331181;5963.254593175853 14:30:21 INFO - PID 12138 | |4;prototype.html;355.0520111302821;368.30022956382885;370.5497820148519;375.6863019378819;384.8595262729103;5303.893922121565;5367.9065164585845;5480.972595137024;5488.615796894219;5491.478309560591;5212.817551385702;5316.4683531646815;5324.361076670805;5325.946740532593;5343.65266257693;4055.1686904184717;4059.3505039193733;4060.1473690525027;4064.2277967186287;4064.268431682296;3893.1824316893485;4046.2514434829504;4048.534418541861;4060.330045542482;4061.4720086388875;4023.295923213441;4032.7580345179235;4033.9596604034023;4039.454673619053;4044.2720310344125;3998.1808277233936;4009.498812648419;4018.698597605162;4030.818613162385;4032.758034517909;3529.6117427083;3531.1172206948263;3534;3536.2927414516944;3542.982285088584;5133.409657889353;5175.870603234912;5235.633505654606;5241.449647786965;5253.317068781034;4707.482176960531;4724.606241158866;4729.9763501182615;4733.337332773414;4738.715677059387;5444.5916556258435;5604.915926261068;5616.129499927518;5630.971845140789;5635.49280564747;3934.645881870617;3935.763854168759;3949.2299001694682;3954.268460334847;3957.3470377387985;5561.277033985596;5901.1969314575235;5943.167956486095;5944.673042982634;5997.130416089686;4016.8551962690494;4022.2156679447226;4027.4160246764054;4029.4157347184496;4029.637332640018;4079.7144199906315;4094.9385759213637;4098.262312783728;4099.077707515845;4100;4623.549518755065;4660.97669511657;4661.440627124767;4715.929261061086;4721.6458765592715;5641.5204707600315;5655.971720141373;5658.519025882763;5662.235598194191;5682.914756278659;1395.3162950154554;1397.3572156807982;1400.271858633505;1402.922839243831;1406.4093080905839;889.4885440871525;936.3445588088365;936.6347124621403;940.7601061729215;945.2249155692266;4903.828366007173;4921.360223170965;4928.605711543068;4937.481564435682;4946.208606622923;5787.276590426197;5787.971060144672;5818.5636077294375;5841.912371314434;5848.239728835224;4785;4887.584555312838;4920;4924.507549245047;4932.235503496964;3074.2621770774854;3106.3476669899123;3112.5019996800856;3117.033719546948;3119.2357872321427;5449.782008719686;5451.373092094381;5458.536024437888;5459;5470.589705772083;5881.559018040607;5950.67271300074;5960.701964901824;5969.671668058299;6017.578769486182;5410.810621628224;5417.83746487606;5428.728563571805;5441.7279136043835;5452.482014208644;5674.177244299636;5819.970900145472;5824.708764561839;5845.883082338414;5900.321463031806;5759.395263497272;5772.422757724194;5773.3072031356505;5790.247267855152;5801.506871915934;5258.526732593932;5384.946150538444;5408.5673146149;5436.401995780382;5440.619156658996;3907.8632247871187;3951.3677811550015;3973.721839471325;4024.3359845625146;4033.173199494038;5839.270091238595;5849.824505264849;5855.824325270249;5872.618279811799;5917.082852157922;5637.88724225505;5683.630564013326;5694.857628559319;5697.515711164598;5701.315842098975;5457.481539253765;5665.688387138747;5684.459976302244;5685.431456854281;5694.259746232963;5592.468715472186;5598.664080155204;5600.69196194197;5608.42963970089;5617.157426386075;5570.61005729595;5653.802116926053;5682.261306030189;5727.6849773262875;5767.250257466502;5532.446755324436;5536.280283563111;5567.351261696529;5569.275994120739;5569.830335629401 14:30:21 INFO - PID 12138 | |5;yui.html;713.1228588835729;743.6690672650673;767.0680123649765;769.5536588778509;785.0500893918359;13638.38627261773;14346.067505612127;14373.209473478968;15953.92023039886;16398.83601163988;16052.197390130475;16284.674306513863;16309.102999335031;16336.34654613817;16337.101459419728;895.8969718482376;903.4037535226752;906.9047749986255;907.0340087806464;908.0102688070002;880.6609455359701;897.0491279243989;899.2626046641757;900.9639614415415;901.1034021148965;944.9905500945006;952.6379975609259;952.7189479103681;957.8275910336137;959.9808003839919;935.3873213045398;949.5252373813128;950.325269058969;951.3863558005118;952.7618095476131;697.2086681616352;700.719712115158;700.982475438113;704.0214102397671;704.1303989572873;14038.719225615532;14229.288535573283;14264.072835265779;14282.785758213635;14314;16320.347186112542;16375.754363684555;16473.34106635733;16475.17624118789;16535.421260255953;12256.81614775779;12351.32067736274;12769.170003949714;12779.105462617621;12902.741945161139;3057.1898446911587;3058.877644894224;3064.034829028871;3066.9079927602206;3076.8153910765427;73977.6301118491;74587.25412745857;75541.99999999945;76394.6180269095;76948.61525692392;12040.879591203975;12342.938285308515;12482.126251162514;12527.874721252852;12549.247045177319;24079;24274.635880461807;24703;24898.253052408458;24963;6398.488120950313;6541.803745887631;6549.770758023446;6553.901691474632;6554.868902621921;2940.8088474249107;2999.2351950252546;3017.5775391445213;3089.964861771332;3125.4217969675683;3629.5281613390616;3713.962860371362;3722.106694393326;3724.981375093107;3749.5875453700073;737.6533029476137;754.4680999895061;764.1327093748636;765.9502132361379;768.4236822383212;566.289306919813;601.2454369765916;608.0878681977034;631.7188850961278;634.9142865713162;10182;10214.233932454947;10685.519151638195;10913.126949843994;11028.28316159447;601.1133577972456;608.2579253310954;612.0452094732232;627.1282916745727;627.2473032361185;4576.908461830745;4751.40607424072;4764.618830493552;4783.1390349736685;4876.268559716071;87418;87628.5618571903;88441.55779221063;88767;91239.54380228056;77434;78024;79887;80543.59728201438;80563;59859.70070149709;63936.68031659905;64278;67036;67858.66070669713;10395;11452;11475.942620286845;11476;11551.480183391599;26918.730812692407;27501;28975;29117;29844.552331715477;50564;53490.197647036104;54411.72794136004;54711;55783.72108139433;14933.253337332873;15215.163166025975;15308.770368444704;15455.53633391;15466.458673946358;16595.50213493597;17142.571435714206;17216.225269862636;17535;17645.558861028578;15314.617134571725;15315.234238287818;15621.375144994528;15689.450869219523;15698.136602486973;14387;14405.42378304856;14616.123032618078;14739.852601473847;14875.925620372262;14784.408623654934;15000.174990375197;15068.924655376653;15187;15335.693286134438;11145.944270278596;11152.219344645797;11404.543818247508;11578.826317605412;11821.704457388634;12273.631791046282;12581.559645412366;12592.685182870502;12599.685007874876;12663.366831658195 14:30:21 INFO - PID 12138 | __end_tp_report 14:30:21 INFO - PID 12138 | __start_cc_report 14:30:21 INFO - PID 12138 | _x_x_mozilla_cycle_collect,346 14:30:21 INFO - PID 12138 | __end_cc_report 14:30:21 INFO - PID 12138 | __startTimestamp1495747821489__endTimestamp 14:30:21 INFO - PID 12138 | 14:30:21 INFO - PID 12138 | ------- Summary: start ------- 14:30:21 INFO - PID 12138 | Number of tests: 6 14:30:21 INFO - PID 12138 | 14:30:21 INFO - PID 12138 | [#0] dojo.html Cycles:165 Average:5160.83 Median:5304.73 stddev:606.66 (11.4%) stddev-sans-first:577.53 14:30:21 INFO - PID 12138 | Values: 2720.5 2725.5 2735.1 2735.4 2761.8 5105.8 5212.3 5213.0 5219.6 5269.3 5208.7 5211.6 5235.6 5303.3 5313.8 4441.7 4597.9 4636.1 4657.3 4667.6 4698.3 4716.6 4728.8 4736.6 4771.6 4554.5 4605.1 4659.3 4663.1 4678.2 4663.3 4668.7 4671.5 4699.5 4707.2 4618.9 4622.6 4630.3 4634.9 4690.2 5139.0 5180.1 5202.2 5210.9 5260.9 5667.2 5677.8 5693.3 5713.3 5731.1 5684.1 5715.6 5720.9 5721.9 5724.1 5199.4 5280.9 5297.1 5304.7 5305.4 5774.5 5850.5 5855.3 5863.5 5865.6 5453.3 5514.7 5520.9 5524.2 5527.9 5612.0 5640.7 5678.9 5700.7 5723.1 5629.3 5632.4 5633.5 5639.3 5643.9 5466.3 5514.1 5564.2 5623.1 5648.0 4656.5 4697.4 4718.6 4722.9 4735.1 4031.0 4045.9 4052.0 4111.2 4130.1 4790.4 4791.9 4792.0 4827.6 4829.1 5494.2 5543.7 5592.7 5674.1 5675.5 4793.2 4795.8 4801.7 4819.3 4841.0 5007.4 5018.9 5022.5 5032.7 5073.7 5191.7 5266.7 5272.1 5277.7 5285.7 5626.3 5692.7 5693.5 5706.5 5712.1 5227.2 5239.1 5239.1 5248.0 5283.6 5544.9 5550.5 5550.6 5556.6 5604.1 5566.2 5635.8 5658.7 5724.3 5749.4 5388.4 5477.4 5481.6 5483.2 5528.7 5436.9 5480.3 5540.8 5554.3 5566.8 5318.5 5369.2 5424.8 5431.0 5435.0 5483.8 5529.6 5534.2 5548.1 5549.9 5322.1 5366.9 5376.1 5380.8 5387.9 14:30:21 INFO - PID 12138 | 14:30:21 INFO - PID 12138 | [#1] ext.html Cycles:180 Average:30934.01 Median:16850.37 stddev:41805.32 (248.1%) stddev-sans-first:41860.68 14:30:21 INFO - PID 12138 | Values: 634.3 678.7 691.0 1175.4 1225.2 35344.6 36333.5 36379.3 36443.0 36496.6 34504.3 34924.7 34972.3 35001.5 35196.0 6534.4 6704.3 6710.9 6720.8 6722.1 6838.1 6915.4 6941.4 6945.2 6953.1 6911.6 6939.7 6970.3 6971.1 6984.7 6913.9 6942.7 6949.4 6951.1 6954.4 6747.1 6800.6 6806.5 6816.3 6819.7 33128.2 33300.2 33358.3 33380.5 33413.7 2954.5 2972.4 2983.8 2986.6 3000.0 24956.9 25145.0 25209.4 25209.9 25233.5 2992.1 3001.7 3015.5 3050.4 3062.1 148285.0 150325.0 150670.0 151399.0 153621.0 39425.6 39599.2 39852.6 39985.8 40061.4 41865.4 42064.6 42183.4 48004.5 48379.3 13323.1 13341.9 13440.8 13462.9 13519.8 10669.1 10719.3 10749.6 10793.9 10816.4 13168.2 13191.3 13257.3 13303.1 13494.9 5495.9 5499.3 5605.6 5704.3 5711.1 871.7 904.4 913.6 915.1 945.4 20966.8 21877.5 21941.8 21961.1 22273.7 971.7 974.4 976.6 990.8 1003.4 11349.0 11496.9 11496.9 11522.7 11576.9 180645.0 181078.0 182358.0 183242.0 183332.0 41557.6 42076.2 42197.6 42352.4 42407.2 1197.1 1240.1 1243.9 1244.6 1251.8 19664.9 19958.3 20440.0 21474.1 21578.1 30112.5 30439.7 30494.5 30645.2 30662.4 149075.3 150918.0 151151.0 151304.0 152124.0 30638.7 30847.7 30967.0 30992.5 31012.8 36591.1 36655.6 36717.4 37096.4 37216.3 25840.9 26921.3 27213.0 27895.4 28331.9 26491.6 26961.7 27035.5 27820.0 28312.9 30918.1 30951.0 31245.5 31283.7 31316.0 25621.6 26524.5 26850.5 27183.3 27529.9 20050.8 22075.8 22161.4 22290.4 22354.9 14:30:21 INFO - PID 12138 | 14:30:21 INFO - PID 12138 | [#2] jquery.html Cycles:180 Average:24872.99 Median:39878.70 stddev:59937.06 (150.3%) stddev-sans-first:60077.04 14:30:21 INFO - PID 12138 | Values: 401.2 408.0 415.8 416.3 431.4 15114.7 16124.5 17110.1 17904.8 17996.8 17873.1 18557.3 18619.8 19112.4 19652.0 5329.6 5491.8 5606.6 5622.4 5624.8 5175.2 5320.3 5323.5 5342.7 5346.7 5062.1 5301.5 5314.3 5320.6 5331.6 5269.5 5270.6 5295.7 5305.9 5310.8 4778.8 4807.4 4892.6 4909.3 4919.8 22744.5 22811.7 22931.3 22957.9 23051.2 1633.7 1635.1 1660.4 1667.6 1672.9 14381.6 14426.1 14849.6 14913.6 14932.5 1984.0 2002.3 2030.3 2044.4 2049.5 93336.0 94980.0 95747.0 95868.0 96173.0 10850.0 11010.7 11067.5 11089.5 11261.8 15546.4 15576.7 15588.7 15590.4 15591.8 7672.6 7730.5 7878.1 7893.4 7933.8 7145.5 7161.4 7180.6 7380.5 7381.2 6922.0 6947.8 7037.9 7070.6 7117.7 2000.6 2012.7 2027.9 2033.6 2108.5 806.8 863.6 875.6 890.0 890.8 17228.4 17515.9 17604.2 17796.5 18159.2 862.3 862.7 864.9 865.4 890.6 9185.4 9374.0 9675.5 9688.6 9749.1 351326.0 355071.0 357125.0 359404.0 363492.0 79517.0 80859.0 80994.0 81986.6 82797.2 1052.6 1058.7 1073.3 1075.3 1078.9 14476.3 14636.1 14643.3 14757.7 15370.8 38089.8 38830.8 39408.8 39807.0 39950.4 49169.5 49281.3 50891.5 51001.2 52009.2 7952.5 7982.3 7984.2 8044.5 8092.8 12737.0 12854.4 12884.7 13027.9 13064.8 10427.8 10679.3 10782.6 10914.5 10929.7 9462.5 9708.0 9880.9 10029.3 10070.8 11127.9 11180.7 11378.4 11543.7 11693.5 7976.3 8220.5 8339.6 8436.2 8443.2 11124.4 11656.9 11863.0 11938.0 12114.7 14:30:21 INFO - PID 12138 | 14:30:21 INFO - PID 12138 | [#3] mootools.html Cycles:180 Average:6677.57 Median:2225.58 stddev:4385.97 (197.1%) stddev-sans-first:4379.51 14:30:21 INFO - PID 12138 | Values: 1278.6 1325.7 1345.1 1346.1 1346.4 10465.7 10934.1 10941.0 10969.6 11247.9 11018.7 11164.6 11168.5 11187.7 11240.6 2151.9 2184.5 2185.3 2199.5 2203.0 2207.2 2221.9 2229.3 2239.5 2255.4 2148.7 2196.6 2203.4 2213.3 2217.3 2130.3 2138.3 2140.6 2142.4 2151.7 2029.1 2070.5 2108.4 2198.2 2199.7 10756.1 10832.9 10840.1 10854.0 10900.9 5519.3 5710.0 5728.4 5733.4 5740.7 3273.1 3412.9 3465.3 3474.5 3478.5 1001.3 1020.1 1025.4 1070.1 1084.5 16257.6 16315.0 16339.1 16360.9 16404.9 4619.5 4802.8 4918.1 4920.7 4933.6 11328.2 11421.1 11422.9 11442.9 11456.4 5503.1 5589.8 5604.1 5612.1 5620.0 5145.5 5172.3 5178.9 5196.5 5208.7 3911.6 3919.8 4013.3 4043.1 4049.1 1110.8 1122.8 1134.4 1138.6 1142.9 718.0 743.6 753.0 759.7 763.3 5870.9 6111.5 6232.1 7025.5 7075.2 844.6 856.7 869.5 872.6 896.0 3845.2 4068.0 4179.6 4377.3 4692.3 13893.6 14339.8 14369.9 14371.6 14373.3 13926.2 13982.9 14574.6 14720.2 14767.2 7274.4 7563.1 7789.6 7942.6 8006.9 6317.9 6469.3 6476.5 6679.8 6782.5 12173.9 12223.3 12543.0 12620.6 12814.7 12913.1 12922.4 12942.4 13128.3 13164.7 9715.0 10012.5 10060.4 10060.8 10089.2 10138.2 10162.1 10172.6 10180.2 10221.2 7957.5 7961.3 8054.0 8748.9 8944.2 7879.6 8055.1 8440.2 8512.1 8699.0 7452.1 7608.8 7717.6 7747.9 7771.8 5516.4 5572.3 5579.3 5649.7 5705.7 5722.4 5818.8 5895.4 5925.6 5963.3 14:30:21 INFO - PID 12138 | 14:30:21 INFO - PID 12138 | [#4] prototype.html Cycles:180 Average:4651.74 Median:5334.80 stddev:1380.88 (25.9%) stddev-sans-first:1346.57 14:30:21 INFO - PID 12138 | Values: 355.1 368.3 370.5 375.7 384.9 5303.9 5367.9 5481.0 5488.6 5491.5 5212.8 5316.5 5324.4 5325.9 5343.7 4055.2 4059.4 4060.1 4064.2 4064.3 3893.2 4046.3 4048.5 4060.3 4061.5 4023.3 4032.8 4034.0 4039.5 4044.3 3998.2 4009.5 4018.7 4030.8 4032.8 3529.6 3531.1 3534.0 3536.3 3543.0 5133.4 5175.9 5235.6 5241.4 5253.3 4707.5 4724.6 4730.0 4733.3 4738.7 5444.6 5604.9 5616.1 5631.0 5635.5 3934.6 3935.8 3949.2 3954.3 3957.3 5561.3 5901.2 5943.2 5944.7 5997.1 4016.9 4022.2 4027.4 4029.4 4029.6 4079.7 4094.9 4098.3 4099.1 4100.0 4623.5 4661.0 4661.4 4715.9 4721.6 5641.5 5656.0 5658.5 5662.2 5682.9 1395.3 1397.4 1400.3 1402.9 1406.4 889.5 936.3 936.6 940.8 945.2 4903.8 4921.4 4928.6 4937.5 4946.2 5787.3 5788.0 5818.6 5841.9 5848.2 4785.0 4887.6 4920.0 4924.5 4932.2 3074.3 3106.3 3112.5 3117.0 3119.2 5449.8 5451.4 5458.5 5459.0 5470.6 5881.6 5950.7 5960.7 5969.7 6017.6 5410.8 5417.8 5428.7 5441.7 5452.5 5674.2 5820.0 5824.7 5845.9 5900.3 5759.4 5772.4 5773.3 5790.2 5801.5 5258.5 5384.9 5408.6 5436.4 5440.6 3907.9 3951.4 3973.7 4024.3 4033.2 5839.3 5849.8 5855.8 5872.6 5917.1 5637.9 5683.6 5694.9 5697.5 5701.3 5457.5 5665.7 5684.5 5685.4 5694.3 5592.5 5598.7 5600.7 5608.4 5617.2 5570.6 5653.8 5682.3 5727.7 5767.3 5532.4 5536.3 5567.4 5569.3 5569.8 14:30:21 INFO - PID 12138 | 14:30:21 INFO - PID 12138 | [#5] yui.html Cycles:180 Average:18154.29 Median:3065.47 stddev:23400.48 (763.4%) stddev-sans-first:23429.48 14:30:21 INFO - PID 12138 | Values: 713.1 743.7 767.1 769.6 785.1 13638.4 14346.1 14373.2 15953.9 16398.8 16052.2 16284.7 16309.1 16336.3 16337.1 895.9 903.4 906.9 907.0 908.0 880.7 897.0 899.3 901.0 901.1 945.0 952.6 952.7 957.8 960.0 935.4 949.5 950.3 951.4 952.8 697.2 700.7 701.0 704.0 704.1 14038.7 14229.3 14264.1 14282.8 14314.0 16320.3 16375.8 16473.3 16475.2 16535.4 12256.8 12351.3 12769.2 12779.1 12902.7 3057.2 3058.9 3064.0 3066.9 3076.8 73977.6 74587.3 75542.0 76394.6 76948.6 12040.9 12342.9 12482.1 12527.9 12549.2 24079.0 24274.6 24703.0 24898.3 24963.0 6398.5 6541.8 6549.8 6553.9 6554.9 2940.8 2999.2 3017.6 3090.0 3125.4 3629.5 3714.0 3722.1 3725.0 3749.6 737.7 754.5 764.1 766.0 768.4 566.3 601.2 608.1 631.7 634.9 10182.0 10214.2 10685.5 10913.1 11028.3 601.1 608.3 612.0 627.1 627.2 4576.9 4751.4 4764.6 4783.1 4876.3 87418.0 87628.6 88441.6 88767.0 91239.5 77434.0 78024.0 79887.0 80543.6 80563.0 59859.7 63936.7 64278.0 67036.0 67858.7 10395.0 11452.0 11475.9 11476.0 11551.5 26918.7 27501.0 28975.0 29117.0 29844.6 50564.0 53490.2 54411.7 54711.0 55783.7 14933.3 15215.2 15308.8 15455.5 15466.5 16595.5 17142.6 17216.2 17535.0 17645.6 15314.6 15315.2 15621.4 15689.5 15698.1 14387.0 14405.4 14616.1 14739.9 14875.9 14784.4 15000.2 15068.9 15187.0 15335.7 11145.9 11152.2 11404.5 11578.8 11821.7 12273.6 12581.6 12592.7 12599.7 12663.4 14:30:21 INFO - PID 12138 | -------- Summary: end -------- 14:30:21 INFO - PID 12138 | 14:30:22 INFO - TEST-INFO | 12138: exit 0 14:30:22 INFO - TEST-OK | dromaeo_css | took 1147085ms 14:30:22 INFO - TEST-START | kraken 14:30:22 INFO - operating with platform_type : linux_ 14:30:22 INFO - Initialising browser for kraken test... 14:30:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52837/getInfo.html -profile /tmp/tmpCHmejf/profile 14:30:22 INFO - TEST-INFO | started process 12549 (/builds/slave/test/build/application/firefox/firefox http://localhost:52837/getInfo.html) 14:30:57 INFO - TEST-INFO | 12549: killed by SIGTERM 14:30:57 INFO - Browser initialized. 14:30:57 INFO - Running cycle 1/1 for kraken test... 14:30:57 INFO - TEST-INFO | started process 12747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCHmejf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:09 INFO - PID 12747 | RSS: Main: 168304640 14:31:09 INFO - PID 12747 | 14:31:12 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52837/tests/kraken/driver.html?testName=audio-beat-detection) 14:31:13 INFO - PID 12747 | RSS: Main: 173928448 14:31:13 INFO - PID 12747 | 14:31:15 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52837/tests/kraken/driver.html?testName=audio-dft) 14:31:16 INFO - PID 12747 | RSS: Main: 173473792 14:31:16 INFO - PID 12747 | 14:31:19 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52837/tests/kraken/driver.html?testName=audio-fft) 14:31:20 INFO - PID 12747 | RSS: Main: 170934272 14:31:20 INFO - PID 12747 | 14:31:22 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52837/tests/kraken/driver.html?testName=audio-oscillator) 14:31:22 INFO - PID 12747 | RSS: Main: 171565056 14:31:22 INFO - PID 12747 | 14:31:24 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52837/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:31:25 INFO - PID 12747 | RSS: Main: 171515904 14:31:25 INFO - PID 12747 | 14:31:28 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52837/tests/kraken/driver.html?testName=imaging-darkroom) 14:31:29 INFO - PID 12747 | RSS: Main: 172642304 14:31:29 INFO - PID 12747 | 14:31:32 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52837/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:33 INFO - PID 12747 | RSS: Main: 171601920 14:31:33 INFO - PID 12747 | 14:31:36 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52837/tests/kraken/driver.html?testName=json-parse-financial) 14:31:36 INFO - PID 12747 | RSS: Main: 172351488 14:31:36 INFO - PID 12747 | 14:31:38 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52837/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:39 INFO - PID 12747 | RSS: Main: 172068864 14:31:39 INFO - PID 12747 | 14:31:40 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52837/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:41 INFO - PID 12747 | RSS: Main: 172445696 14:31:41 INFO - PID 12747 | 14:31:43 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52837/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:44 INFO - PID 12747 | RSS: Main: 171937792 14:31:44 INFO - PID 12747 | 14:31:47 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:47 INFO - PID 12747 | RSS: Main: 172265472 14:31:47 INFO - PID 12747 | 14:31:51 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:51 INFO - PID 12747 | RSS: Main: 172212224 14:31:51 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | Cycle 1(1): loaded http://localhost:52837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52837/tests/kraken/driver.html?testName=ai-astar) 14:31:53 INFO - PID 12747 | RSS: Main: 173625344 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | __start_tp_report 14:31:53 INFO - PID 12747 | _x_x_mozilla_page_load 14:31:53 INFO - PID 12747 | _x_x_mozilla_page_load_details 14:31:53 INFO - PID 12747 | |i|pagename|runs| 14:31:53 INFO - PID 12747 | |0;ai-astar;103;115;113;111;112;112;112;113;112;114 14:31:53 INFO - PID 12747 | |1;audio-beat-detection;165;132;123;181;125;123;128;128;149;128 14:31:53 INFO - PID 12747 | |2;audio-dft;165;165;164;166;170;168;166;164;166;163 14:31:53 INFO - PID 12747 | |3;audio-fft;76;73;74;114;74;74;77;74;95;74 14:31:53 INFO - PID 12747 | |4;audio-oscillator;84;82;106;84;84;83;99;82;83;106 14:31:53 INFO - PID 12747 | |5;imaging-gaussian-blur;114;115;114;115;114;114;114;115;113;114 14:31:53 INFO - PID 12747 | |6;imaging-darkroom;152;155;151;153;151;151;151;152;151;151 14:31:53 INFO - PID 12747 | |7;imaging-desaturate;96;96;95;95;94;95;94;94;94;95 14:31:53 INFO - PID 12747 | |8;json-parse-financial;54;56;55;55;56;55;55;55;54;54 14:31:53 INFO - PID 12747 | |9;json-stringify-tinderbox;57;57;56;56;56;56;56;57;57;57 14:31:53 INFO - PID 12747 | |10;stanford-crypto-aes;88;97;96;87;86;87;91;87;129;87 14:31:53 INFO - PID 12747 | |11;stanford-crypto-ccm;141;136;132;134;138;132;140;144;136;139 14:31:53 INFO - PID 12747 | |12;stanford-crypto-pbkdf2;206;207;199;193;210;207;202;209;201;198 14:31:53 INFO - PID 12747 | |13;stanford-crypto-sha256-iterative;78;76;72;74;76;76;77;75;73;75 14:31:53 INFO - PID 12747 | __end_tp_report 14:31:53 INFO - PID 12747 | __start_cc_report 14:31:53 INFO - PID 12747 | _x_x_mozilla_cycle_collect,883 14:31:53 INFO - PID 12747 | __end_cc_report 14:31:53 INFO - PID 12747 | __startTimestamp1495747913757__endTimestamp 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | ------- Summary: start ------- 14:31:53 INFO - PID 12747 | Number of tests: 14 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.50 stddev:3.27 (2.9%) stddev-sans-first:1.22 14:31:53 INFO - PID 12747 | Values: 103.0 115.0 113.0 111.0 112.0 112.0 112.0 113.0 112.0 114.0 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#1] audio-beat-detection Cycles:10 Average:138.20 Median:130.00 stddev:20.15 (15.5%) stddev-sans-first:18.89 14:31:53 INFO - PID 12747 | Values: 165.0 132.0 123.0 181.0 125.0 123.0 128.0 128.0 149.0 128.0 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#2] audio-dft Cycles:10 Average:165.70 Median:166.00 stddev:2.06 (1.2%) stddev-sans-first:2.17 14:31:53 INFO - PID 12747 | Values: 165.0 165.0 164.0 166.0 170.0 168.0 166.0 164.0 166.0 163.0 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#3] audio-fft Cycles:10 Average:80.50 Median:74.00 stddev:13.47 (18.2%) stddev-sans-first:14.19 14:31:53 INFO - PID 12747 | Values: 76.0 73.0 74.0 114.0 74.0 74.0 77.0 74.0 95.0 74.0 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:83.50 stddev:10.12 (12.1%) stddev-sans-first:10.55 14:31:53 INFO - PID 12747 | Values: 84.0 82.0 106.0 84.0 84.0 83.0 99.0 82.0 83.0 106.0 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 14:31:53 INFO - PID 12747 | Values: 114.0 115.0 114.0 115.0 114.0 114.0 114.0 115.0 113.0 114.0 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:151.50 stddev:1.32 (0.9%) stddev-sans-first:1.39 14:31:53 INFO - PID 12747 | Values: 152.0 155.0 151.0 153.0 151.0 151.0 151.0 152.0 151.0 151.0 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.71 14:31:53 INFO - PID 12747 | Values: 96.0 96.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.74 (1.3%) stddev-sans-first:0.71 14:31:53 INFO - PID 12747 | Values: 54.0 56.0 55.0 55.0 56.0 55.0 55.0 55.0 54.0 54.0 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:57.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 14:31:53 INFO - PID 12747 | Values: 57.0 57.0 56.0 56.0 56.0 56.0 56.0 57.0 57.0 57.0 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#10] stanford-crypto-aes Cycles:10 Average:93.50 Median:87.50 stddev:13.08 (15.0%) stddev-sans-first:13.72 14:31:53 INFO - PID 12747 | Values: 88.0 97.0 96.0 87.0 86.0 87.0 91.0 87.0 129.0 87.0 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:138.50 stddev:3.94 (2.8%) stddev-sans-first:3.93 14:31:53 INFO - PID 12747 | Values: 141.0 136.0 132.0 134.0 138.0 132.0 140.0 144.0 136.0 139.0 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:203.20 Median:206.50 stddev:5.49 (2.7%) stddev-sans-first:5.73 14:31:53 INFO - PID 12747 | Values: 206.0 207.0 199.0 193.0 210.0 207.0 202.0 209.0 201.0 198.0 14:31:53 INFO - PID 12747 | 14:31:53 INFO - PID 12747 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:76.00 stddev:1.81 (2.4%) stddev-sans-first:1.62 14:31:53 INFO - PID 12747 | Values: 78.0 76.0 72.0 74.0 76.0 76.0 77.0 75.0 73.0 75.0 14:31:53 INFO - PID 12747 | -------- Summary: end -------- 14:31:53 INFO - PID 12747 | 14:31:54 INFO - TEST-INFO | 12747: exit 0 14:31:54 INFO - TEST-OK | kraken | took 92589ms 14:31:54 INFO - SUITE-END | took 1239s 14:31:54 INFO - Completed test suite (00:20:39) 14:31:54 INFO - javascript benchmark 14:31:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6848.988843386329, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2720.537508623534, 2725.5230334691423, 2735.0837469447733, 2735.398212393273, 2761.779057675385, 5105.795768169278, 5212.322398088253, 5213.0, 5219.634625576206, 5269.262303277539, 5208.661437006592, 5211.557017653495, 5235.633505654606, 5303.284056652351, 5313.814016509423, 4441.7044216321565, 4597.862064138065, 4636.09596128755, 4657.32468792025, 4667.649926255544, 4698.271767875985, 4716.646251531131, 4728.763561821912, 4736.573708366246, 4771.570558649721, 4554.4990051094355, 4605.078984203173, 4659.254519276899, 4663.067386522675, 4678.204705200124, 4663.323818046364, 4668.6731928765, 4671.532846715335, 4699.506551812045, 4707.223308154151, 4618.861434156981, 4622.6301895848255, 4630.259158534618, 4634.86095417138, 4690.249560070407, 5139.0, 5180.093483640348, 5202.193659982709, 5210.947890521122, 5260.921086183672, 5667.206591077253, 5677.829665110054, 5693.28833895763, 5713.342965558931, 5731.111677689923, 5684.062129748587, 5715.571332150105, 5720.885582288331, 5721.9427805721825, 5724.084146536576, 5199.376074871039, 5280.891012887259, 5297.073012222845, 5304.734763261821, 5305.389880163753, 5774.451427114417, 5850.5027072699295, 5855.268091488564, 5863.472287494146, 5865.589408741347, 5453.263809385682, 5514.696691681916, 5520.861978450571, 5524.171374293888, 5527.861803454945, 5612.045952188138, 5640.689762063043, 5678.914816277759, 5700.657960522382, 5723.055695810228, 5629.268195134607, 5632.436756324417, 5633.464820842013, 5639.295088113986, 5643.887122257532, 5466.262054622654, 5514.145307477347, 5564.221009058735, 5623.072193088176, 5647.971760141173, 4656.511066338054, 4697.436307643105, 4718.622510199176, 4722.858314250578, 4735.147673418817, 4030.9596904030586, 4045.8786236412957, 4052.0, 4111.177764447122, 4130.091379896418, 4790.377250957354, 4791.856244312677, 4791.976040119777, 4827.61379089672, 4829.106615276185, 5494.1758736189095, 5543.695096769717, 5592.720363981784, 5674.120511320752, 5675.517581005661, 4793.18515852306, 4795.832145874878, 4801.7118972861745, 4819.325294458778, 4840.975795121002, 5007.4491805901325, 5018.89962200754, 5022.547970682656, 5032.748362581856, 5073.695578265316, 5191.740412979411, 5266.710330931835, 5272.0773864572775, 5277.656952298012, 5285.68285902847, 5626.324841019104, 5692.658440493418, 5693.4875861172695, 5706.543476521785, 5712.11462223356, 5227.18978558324, 5239.05696974533, 5239.08316044683, 5248.0, 5283.603729720363, 5544.861378465571, 5550.47270509301, 5550.55595552363, 5556.638818476786, 5604.103343465026, 5566.165075238585, 5635.774569017193, 5658.745356458887, 5724.284464441945, 5749.396313387034, 5388.434214407431, 5477.4248703887115, 5481.561475082063, 5483.150111732688, 5528.668279903219, 5436.9456305438025, 5480.260164877691, 5540.778368865362, 5554.2779438672715, 5566.777328906798, 5318.468153184651, 5369.221462887937, 5424.755885985219, 5430.972845135749, 5435.0, 5483.8080667176455, 5529.557635389078, 5534.1975413565615, 5548.056830338933, 5549.889002219852, 5322.148456246982, 5366.946330536644, 5376.112941364788, 5380.838574842761, 5387.919181212364], "value": 5116.864974261231, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.3181080338637, 678.684411748537, 690.9861802763943, 1175.371176420615, 1225.166886517168, 35344.646553534454, 36333.45499817502, 36379.27241455173, 36443.0, 36496.635033649654, 34504.30991380177, 34924.65075349246, 34972.300553988905, 35001.474977875354, 35196.0, 6534.411902928748, 6704.329567043281, 6710.932890671104, 6720.83197920051, 6722.1261236039245, 6838.11104556407, 6915.377616014558, 6941.444684425234, 6945.201301850276, 6953.061336719554, 6911.5853048817235, 6939.653017349137, 6970.337817907316, 6971.093757811503, 6984.720611175547, 6913.861722765541, 6942.687579058955, 6949.3745562899585, 6951.0616066830835, 6954.40887524561, 6747.122874026345, 6800.557963732391, 6806.489513286523, 6816.284290149512, 6819.727210911557, 33128.17179570506, 33300.1674958128, 33358.33283334344, 33380.499292510634, 33413.665863341295, 2954.4534261161753, 2972.3609423973735, 2983.820970741741, 2986.566947792558, 3000.0, 24956.875215623804, 25145.0, 25209.369765756004, 25209.873950630314, 25233.49533009348, 2992.07245753817, 3001.654809696891, 3015.522394026933, 3050.4051709916575, 3062.0507642630855, 148285.0, 150325.0, 150670.0, 151399.0, 153620.9999999989, 39425.60574394277, 39599.20801583952, 39852.60147398489, 39985.80007100004, 40061.39907901384, 41865.37201941973, 42064.579354206675, 42183.36724949128, 48004.5199548, 48379.27431088537, 13323.067385282937, 13341.93329033368, 13440.798388024188, 13462.932685336707, 13519.797203041962, 10669.146468282674, 10719.303245289031, 10749.62376316825, 10793.892061079288, 10816.351018938889, 13168.209907405586, 13191.340432978313, 13257.337133143305, 13303.135296205715, 13494.865051349361, 5495.862603434946, 5499.340079190522, 5605.579581531401, 5704.315482142087, 5711.086226203871, 871.7079778274223, 904.4347282948157, 913.5569248914271, 915.1443400420628, 945.4280160502934, 20966.79033209679, 21877.453063673536, 21941.780582193973, 21961.121555137936, 22273.66589501159, 971.7182017214928, 974.3763991045737, 976.6044751875502, 990.7721224118493, 1003.3528374198601, 11349.0, 11496.942515287537, 11496.942515287537, 11522.654320370235, 11576.94211528937, 180645.0, 181078.0, 182358.0, 183242.0, 183332.0, 41557.584424155975, 42076.15847683029, 42197.578024219365, 42352.36471452931, 42407.151856962686, 1197.126097948485, 1240.138104017717, 1243.9315837628835, 1244.6141696074064, 1251.8122281657825, 19664.901675492103, 19958.30145944885, 20440.0, 21474.14103435845, 21578.136874524844, 30112.548311774903, 30439.695603043685, 30494.542581861733, 30645.23386915345, 30662.386752265276, 149075.25462372618, 150918.0, 151151.0, 151304.0, 152124.0, 30638.693613063584, 30847.69152308538, 30967.0, 30992.53511197379, 31012.844935775178, 36591.08522286964, 36655.63344366629, 36717.44923826091, 37096.443553347264, 37216.25567488581, 25840.8707956459, 26921.326966825985, 27213.0, 27895.442091158468, 28331.858340708164, 26491.60262596024, 26961.73038269592, 27035.459290814466, 27820.0, 28312.85843570769, 30918.0724578263, 30951.0, 31245.531317029807, 31283.687163128987, 31316.0, 25621.615675764504, 26524.469510610066, 26850.462990740467, 27183.320416989733, 27529.86235068812, 20050.799492004895, 22075.779242208017, 22161.445963850387, 22290.442738931655, 22354.888225558767], "value": 14730.602772811284, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.2016087984909, 407.9938800917985, 415.81496234175785, 416.25282617701225, 431.4326660441519, 15114.697706045872, 16124.516264512054, 17110.144492775373, 17904.82095179048, 17996.820031799678, 17873.10634468278, 18557.257709691596, 18619.813801862012, 19112.42662720117, 19652.0, 5329.573634109282, 5491.780328786844, 5606.55147588194, 5622.381538030813, 5624.775008999635, 5175.197844334115, 5320.255164276985, 5323.520883120518, 5342.732863356836, 5346.705931173784, 5062.139436295838, 5301.5228629423345, 5314.3091398118195, 5320.600954928376, 5331.6267861249535, 5269.499397557226, 5270.604704647148, 5295.708736019517, 5305.920411193816, 5310.840674779763, 4778.80884764609, 4807.42310922688, 4892.584130348924, 4909.263610458424, 4919.827806026772, 22744.54510909789, 22811.657825132635, 22931.312060638207, 22957.885210574008, 23051.193208237797, 1633.6977659132979, 1635.1497221444902, 1660.3524625396105, 1667.6164482169047, 1672.9414470493596, 14381.64045898861, 14426.134431934117, 14849.628759280997, 14913.627159320995, 14932.50674932509, 1984.0, 2002.3192114680933, 2030.2792508659509, 2044.3866839947957, 2049.477383267272, 93335.99999999932, 94980.0, 95747.0, 95868.0, 96173.0, 10850.0, 11010.669679909615, 11067.50196241171, 11089.451375559744, 11261.774764504664, 15546.413807926463, 15576.688466230611, 15588.688226235412, 15590.376384944475, 15591.844081559038, 7672.578008209602, 7730.458867879307, 7878.094019187867, 7893.368530517545, 7933.801654958556, 7145.499815013003, 7161.391281741006, 7180.640967951582, 7380.483366164317, 7381.151167615685, 6922.0, 6947.756828510978, 7037.859242815115, 7070.646467676595, 7117.679704413314, 2000.6298834715624, 2012.6679097948968, 2027.9188832446537, 2033.5526184239739, 2108.5134979839177, 806.7539400482792, 863.5845232107001, 875.5622188905547, 890.0298674444886, 890.7550423633423, 17228.397006104726, 17515.912420437817, 17604.207810648553, 17796.46610601684, 18159.182836772114, 862.2929198057533, 862.6808081010066, 864.8789169516273, 865.4288169807896, 890.5680744838749, 9185.402948808307, 9373.953130234442, 9675.467849268218, 9688.564014619358, 9749.07383798538, 351326.0, 355071.0, 357125.0, 359404.0, 363492.0, 79517.0, 80859.0, 80994.0, 81986.59006704928, 82797.17202827895, 1052.578968412641, 1058.6771034834449, 1073.3398959639921, 1075.3279200499687, 1078.9352638841694, 14476.276186190858, 14636.121832690073, 14643.26783660834, 14757.704845903236, 15370.769438458656, 38089.809550952064, 38830.805845970586, 39408.80295598504, 39807.0, 39950.40074398944, 49169.50830491649, 49281.26078108903, 50891.49108509016, 51001.23498147605, 52009.21986170135, 7952.522848629101, 7982.321502672338, 7984.24149705777, 8044.517328960281, 8092.797680058045, 12736.968897285706, 12854.421551030413, 12884.677883052624, 13027.869721302666, 13064.80402793978, 10427.843582346422, 10679.305845120043, 10782.568697252022, 10914.50884710174, 10929.726756830825, 9462.479563624067, 9707.951460242653, 9880.901190988287, 10029.297949143782, 10070.798584028133, 11127.944360278147, 11180.720481988015, 11378.43107844621, 11543.711407214887, 11693.532258709556, 7976.322012628992, 8220.506769593843, 8339.624716887633, 8436.24073833358, 8443.155684431753, 11124.443777811239, 11656.88343116558, 11863.0, 11937.970545007196, 12114.697132571757], "value": 8820.172451957642, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1278.552506622682, 1325.6553296143, 1345.1122259308852, 1346.1384713783175, 1346.4143097752478, 10465.68602941912, 10934.070603998649, 10941.015308622222, 10969.561217551289, 11247.887521124787, 11018.669439916815, 11164.609238676649, 11168.497417616207, 11187.720306992329, 11240.606578769744, 2151.870887746736, 2184.4975655599224, 2185.344396680989, 2199.461132022657, 2203.0416768705663, 2207.227470385368, 2221.8777967211795, 2229.27231395668, 2239.529698763262, 2255.4135924659627, 2148.699182114505, 2196.5826492966366, 2203.3720389688942, 2213.302809614974, 2217.2572188316935, 2130.275706259871, 2138.3050508584774, 2140.6039882621685, 2142.37871017404, 2151.655735082379, 2029.0564887327464, 2070.4616799632054, 2108.3569511299047, 2198.208644887839, 2199.681046248301, 10756.139508839353, 10832.891671083267, 10840.078593319577, 10854.0, 10900.945495272552, 5519.337679478448, 5710.0, 5728.398518155617, 5733.369329373765, 5740.655560666373, 3273.116258610186, 3412.8805491807916, 3465.3069386122875, 3474.5483087198504, 3478.5477887874413, 1001.324106228293, 1020.1023099672315, 1025.354026963016, 1070.138538476526, 1084.4740300954031, 16257.593560160973, 16315.0, 16339.101349425777, 16360.918195408947, 16404.917975410284, 4619.514950930171, 4802.759862006886, 4918.0901533216465, 4920.6801557898625, 4933.580645645088, 11328.150388720878, 11421.143414243965, 11422.914823091793, 11442.94278528602, 11456.369899655432, 5503.11950087992, 5589.804356847572, 5604.103343465026, 5612.130119831432, 5619.971900140473, 5145.4854514549, 5172.27588137661, 5178.948210517847, 5196.45437229093, 5208.6874787512115, 3911.6283953024417, 3919.8236079375924, 4013.2976729072298, 4043.130726893732, 4049.1091959768805, 1110.8167152419921, 1122.7586068995042, 1134.3987686526154, 1138.6242539961793, 1142.9085673146128, 717.989230161548, 743.5724458436421, 752.9623518824037, 759.7189040055215, 763.3320844261272, 5870.911936320958, 6111.5110791137495, 6232.065190221412, 7025.473089518307, 7075.2217256101785, 844.6072576252072, 856.6873091321747, 869.4956924983494, 872.6247713483136, 896.0457113174448, 3845.1540661054523, 4067.9796601016806, 4179.561146079618, 4377.299632058855, 4692.319613656001, 13893.58319250424, 14339.78490322646, 14369.928150359181, 14371.568852934428, 14373.28133593337, 13926.234057126956, 13982.930085349508, 14574.635634109232, 14720.19038952868, 14767.187804670846, 7274.418046556369, 7563.054618172839, 7789.571573563395, 7942.602869856484, 8006.919930800734, 6317.9052314214405, 6469.256035555972, 6476.546641735222, 6679.799606011828, 6782.491313151632, 12173.939130304292, 12223.266604003788, 12543.0, 12620.55828046014, 12814.743705125658, 12913.079284270496, 12922.353882305659, 12942.417591208607, 13128.277944713132, 13164.670883227996, 9714.95142524311, 10012.549435275285, 10060.396376217157, 10060.798784024424, 10089.243306751876, 10138.239632027775, 10162.136218421518, 10172.593096276361, 10180.185585153022, 10221.23340749432, 7957.482763620577, 7961.283484486424, 8054.0, 8748.868766968628, 8944.239739622206, 7879.566623835744, 8055.073666528424, 8440.198181172778, 8512.148785121439, 8698.956505217433, 7452.105747310357, 7608.8478230436185, 7717.575533345495, 7747.883781743166, 7771.805704857424, 5516.393196748435, 5572.3034620672415, 5579.330480342385, 5649.661020338793, 5705.743241554057, 5722.4277572242445, 5818.796342128175, 5895.380984996686, 5925.555583331181, 5963.254593175853], "value": 4958.531347799366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.0520111302821, 368.30022956382885, 370.5497820148519, 375.6863019378819, 384.8595262729103, 5303.893922121565, 5367.9065164585845, 5480.972595137024, 5488.615796894219, 5491.478309560591, 5212.817551385702, 5316.4683531646815, 5324.361076670805, 5325.946740532593, 5343.65266257693, 4055.1686904184717, 4059.3505039193733, 4060.1473690525027, 4064.2277967186287, 4064.268431682296, 3893.1824316893485, 4046.2514434829504, 4048.534418541861, 4060.330045542482, 4061.4720086388875, 4023.295923213441, 4032.7580345179235, 4033.9596604034023, 4039.454673619053, 4044.2720310344125, 3998.1808277233936, 4009.498812648419, 4018.698597605162, 4030.818613162385, 4032.758034517909, 3529.6117427083, 3531.1172206948263, 3534.0, 3536.2927414516944, 3542.982285088584, 5133.409657889353, 5175.870603234912, 5235.633505654606, 5241.449647786965, 5253.317068781034, 4707.482176960531, 4724.606241158866, 4729.9763501182615, 4733.337332773414, 4738.715677059387, 5444.5916556258435, 5604.915926261068, 5616.129499927518, 5630.971845140789, 5635.49280564747, 3934.645881870617, 3935.763854168759, 3949.2299001694682, 3954.268460334847, 3957.3470377387985, 5561.277033985596, 5901.1969314575235, 5943.167956486095, 5944.673042982634, 5997.130416089686, 4016.8551962690494, 4022.2156679447226, 4027.4160246764054, 4029.4157347184496, 4029.637332640018, 4079.7144199906315, 4094.9385759213637, 4098.262312783728, 4099.077707515845, 4100.0, 4623.549518755065, 4660.97669511657, 4661.440627124767, 4715.929261061086, 4721.6458765592715, 5641.5204707600315, 5655.971720141373, 5658.519025882763, 5662.235598194191, 5682.914756278659, 1395.3162950154554, 1397.3572156807982, 1400.271858633505, 1402.922839243831, 1406.4093080905839, 889.4885440871525, 936.3445588088365, 936.6347124621403, 940.7601061729215, 945.2249155692266, 4903.828366007173, 4921.360223170965, 4928.605711543068, 4937.481564435682, 4946.208606622923, 5787.276590426197, 5787.971060144672, 5818.5636077294375, 5841.912371314434, 5848.239728835224, 4785.0, 4887.584555312838, 4920.0, 4924.507549245047, 4932.235503496964, 3074.2621770774854, 3106.3476669899123, 3112.5019996800856, 3117.033719546948, 3119.2357872321427, 5449.782008719686, 5451.373092094381, 5458.536024437888, 5459.0, 5470.589705772083, 5881.559018040607, 5950.67271300074, 5960.701964901824, 5969.671668058299, 6017.578769486182, 5410.810621628224, 5417.83746487606, 5428.728563571805, 5441.7279136043835, 5452.482014208644, 5674.177244299636, 5819.970900145472, 5824.708764561839, 5845.883082338414, 5900.321463031806, 5759.395263497272, 5772.422757724194, 5773.3072031356505, 5790.247267855152, 5801.506871915934, 5258.526732593932, 5384.946150538444, 5408.5673146149, 5436.401995780382, 5440.619156658996, 3907.8632247871187, 3951.3677811550015, 3973.721839471325, 4024.3359845625146, 4033.173199494038, 5839.270091238595, 5849.824505264849, 5855.824325270249, 5872.618279811799, 5917.082852157922, 5637.88724225505, 5683.630564013326, 5694.857628559319, 5697.515711164598, 5701.315842098975, 5457.481539253765, 5665.688387138747, 5684.459976302244, 5685.431456854281, 5694.259746232963, 5592.468715472186, 5598.664080155204, 5600.69196194197, 5608.42963970089, 5617.157426386075, 5570.61005729595, 5653.802116926053, 5682.261306030189, 5727.6849773262875, 5767.250257466502, 5532.446755324436, 5536.280283563111, 5567.351261696529, 5569.275994120739, 5569.830335629401], "value": 4223.106192592437, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.1228588835729, 743.6690672650673, 767.0680123649765, 769.5536588778509, 785.0500893918359, 13638.38627261773, 14346.067505612127, 14373.209473478968, 15953.92023039886, 16398.83601163988, 16052.197390130475, 16284.674306513863, 16309.102999335031, 16336.34654613817, 16337.101459419728, 895.8969718482376, 903.4037535226752, 906.9047749986255, 907.0340087806464, 908.0102688070002, 880.6609455359701, 897.0491279243989, 899.2626046641757, 900.9639614415415, 901.1034021148965, 944.9905500945006, 952.6379975609259, 952.7189479103681, 957.8275910336137, 959.9808003839919, 935.3873213045398, 949.5252373813128, 950.325269058969, 951.3863558005118, 952.7618095476131, 697.2086681616352, 700.719712115158, 700.982475438113, 704.0214102397671, 704.1303989572873, 14038.719225615532, 14229.288535573283, 14264.072835265779, 14282.785758213635, 14314.0, 16320.347186112542, 16375.754363684555, 16473.34106635733, 16475.17624118789, 16535.421260255953, 12256.81614775779, 12351.32067736274, 12769.170003949714, 12779.105462617621, 12902.741945161139, 3057.1898446911587, 3058.877644894224, 3064.034829028871, 3066.9079927602206, 3076.8153910765427, 73977.6301118491, 74587.25412745857, 75541.99999999945, 76394.6180269095, 76948.61525692392, 12040.879591203975, 12342.938285308515, 12482.126251162514, 12527.874721252852, 12549.247045177319, 24079.0, 24274.635880461807, 24703.0, 24898.253052408458, 24963.0, 6398.488120950313, 6541.803745887631, 6549.770758023446, 6553.901691474632, 6554.868902621921, 2940.8088474249107, 2999.2351950252546, 3017.5775391445213, 3089.964861771332, 3125.4217969675683, 3629.5281613390616, 3713.962860371362, 3722.106694393326, 3724.981375093107, 3749.5875453700073, 737.6533029476137, 754.4680999895061, 764.1327093748636, 765.9502132361379, 768.4236822383212, 566.289306919813, 601.2454369765916, 608.0878681977034, 631.7188850961278, 634.9142865713162, 10182.0, 10214.233932454947, 10685.519151638195, 10913.126949843994, 11028.28316159447, 601.1133577972456, 608.2579253310954, 612.0452094732232, 627.1282916745727, 627.2473032361185, 4576.908461830745, 4751.40607424072, 4764.618830493552, 4783.1390349736685, 4876.268559716071, 87418.0, 87628.5618571903, 88441.55779221063, 88767.0, 91239.54380228056, 77434.0, 78024.0, 79887.0, 80543.59728201438, 80563.0, 59859.70070149709, 63936.68031659905, 64278.0, 67036.0, 67858.66070669713, 10395.0, 11452.0, 11475.942620286845, 11476.0, 11551.480183391599, 26918.730812692407, 27501.0, 28975.0, 29117.0, 29844.552331715477, 50564.0, 53490.197647036104, 54411.72794136004, 54711.0, 55783.72108139433, 14933.253337332873, 15215.163166025975, 15308.770368444704, 15455.53633391, 15466.458673946358, 16595.50213493597, 17142.571435714206, 17216.225269862636, 17535.0, 17645.558861028578, 15314.617134571725, 15315.234238287818, 15621.375144994528, 15689.450869219523, 15698.136602486973, 14387.0, 14405.42378304856, 14616.123032618078, 14739.852601473847, 14875.925620372262, 14784.408623654934, 15000.174990375197, 15068.924655376653, 15187.0, 15335.693286134438, 11145.944270278596, 11152.219344645797, 11404.543818247508, 11578.826317605412, 11821.704457388634, 12273.631791046282, 12581.559645412366, 12592.685182870502, 12599.685007874876, 12663.366831658195], "value": 7413.7853220759125, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 113.0, 111.0, 112.0, 112.0, 112.0, 113.0, 112.0, 114.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 132.0, 123.0, 181.0, 125.0, 123.0, 128.0, 128.0, 149.0, 128.0], "value": 138.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 166.0, 170.0, 168.0, 166.0, 164.0, 166.0, 163.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 74.0, 114.0, 74.0, 74.0, 77.0, 74.0, 95.0, 74.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 106.0, 84.0, 84.0, 83.0, 99.0, 82.0, 83.0, 106.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 113.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 155.0, 151.0, 153.0, 151.0, 151.0, 151.0, 152.0, 151.0, 151.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 55.0, 56.0, 55.0, 55.0, 55.0, 54.0, 54.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 56.0, 56.0, 56.0, 56.0, 57.0, 57.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 97.0, 96.0, 87.0, 86.0, 87.0, 91.0, 87.0, 129.0, 87.0], "value": 93.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 136.0, 132.0, 134.0, 138.0, 132.0, 140.0, 144.0, 136.0, 139.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 207.0, 199.0, 193.0, 210.0, 207.0, 202.0, 209.0, 201.0, 198.0], "value": 203.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 72.0, 74.0, 76.0, 76.0, 77.0, 75.0, 73.0, 75.0], "value": 75.2, "unit": "score"}]}]} 14:31:55 INFO - Return code: 0 14:31:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:31:55 INFO - # TBPL SUCCESS # 14:31:55 INFO - Running post-action listener: _resource_record_post_action 14:31:55 INFO - [mozharness: 2017-05-25 21:31:55.080228Z] Finished run-tests step (success) 14:31:55 INFO - Running post-run listener: _resource_record_post_run 14:31:55 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400248832; Read time: 8; Write time: 476112 14:31:55 INFO - TinderboxPrint: CPU usage
12.7% 14:31:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 14:31:55 INFO - TinderboxPrint: I/O write bytes / time
400,248,832 / 476,112 14:31:55 INFO - TinderboxPrint: CPU idle
8,753.9 (87.3%) 14:31:55 INFO - TinderboxPrint: CPU user
1,212.8 (12.1%) 14:31:55 INFO - TinderboxPrint: Swap in / out
0 / 0 14:31:55 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 97460224; Read time: 0; Write time: 165096 14:31:55 INFO - run-tests - Wall time: 1240s; CPU: 13.0%; Read bytes: 0; Write bytes: 302788608; Read time: 0; Write time: 311016 14:31:55 INFO - Running post-run listener: _upload_blobber_files 14:31:55 INFO - Blob upload gear active. 14:31:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:31:55 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 14:31:55 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'] 14:31:55 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 14:31:56 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:31:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:31:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:56 INFO - (blobuploader) - INFO - Done attempting. 14:31:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:31:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:31:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:59 INFO - (blobuploader) - INFO - Done attempting. 14:31:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:31:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:32:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:07 INFO - (blobuploader) - INFO - Done attempting. 14:32:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:32:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:32:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:08 INFO - (blobuploader) - INFO - Done attempting. 14:32:08 INFO - (blobuploader) - INFO - Iteration through files over. 14:32:08 INFO - Return code: 0 14:32:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:32:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:32:08 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e684fa7f2307a992c18e3e35e4b22491da3bb03c37a9a8c163a3bd13e6b6515ebcd7cb4c77c6ca854bd975403b292b4054ef0601e3c15e3a93bf7c45a3fa5412", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6f5adb538dc3c0eee2733f914566289f9034cfcf03cc078f66bd8f50605789f35629461362594739536d1ef0a927563f8b1714145ff2449e089b3c6409803a8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa5d216582a34e8f7f0737e6bad1474ec6bde0071782fa688fa0885ea4688b597fc07bc56b7a9fcba7e230f6140932cdf973f8e3aaeb1d9464c2e5a5e557a0af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7230380c2e215d77dce23a5f67123f7dd07704abb0ff1e2877fd629ca73abd9ed4f2a38a2fb3a6eb9e23875281e2ee977037c0e5cdc97c1aaa03d538fb9ed87"} 14:32:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:32:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:32:08 INFO - Contents: 14:32:08 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e684fa7f2307a992c18e3e35e4b22491da3bb03c37a9a8c163a3bd13e6b6515ebcd7cb4c77c6ca854bd975403b292b4054ef0601e3c15e3a93bf7c45a3fa5412", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6f5adb538dc3c0eee2733f914566289f9034cfcf03cc078f66bd8f50605789f35629461362594739536d1ef0a927563f8b1714145ff2449e089b3c6409803a8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa5d216582a34e8f7f0737e6bad1474ec6bde0071782fa688fa0885ea4688b597fc07bc56b7a9fcba7e230f6140932cdf973f8e3aaeb1d9464c2e5a5e557a0af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7230380c2e215d77dce23a5f67123f7dd07704abb0ff1e2877fd629ca73abd9ed4f2a38a2fb3a6eb9e23875281e2ee977037c0e5cdc97c1aaa03d538fb9ed87"} 14:32:08 INFO - Running post-run listener: copy_logs_to_upload_dir 14:32:08 INFO - Copying logs to upload dir... 14:32:08 INFO - mkdir: /builds/slave/test/build/upload/logs 14:32:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1319.818480 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-05-25 14:32:08.210591) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 14:32:08.215316) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537 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/e684fa7f2307a992c18e3e35e4b22491da3bb03c37a9a8c163a3bd13e6b6515ebcd7cb4c77c6ca854bd975403b292b4054ef0601e3c15e3a93bf7c45a3fa5412", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6f5adb538dc3c0eee2733f914566289f9034cfcf03cc078f66bd8f50605789f35629461362594739536d1ef0a927563f8b1714145ff2449e089b3c6409803a8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa5d216582a34e8f7f0737e6bad1474ec6bde0071782fa688fa0885ea4688b597fc07bc56b7a9fcba7e230f6140932cdf973f8e3aaeb1d9464c2e5a5e557a0af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7230380c2e215d77dce23a5f67123f7dd07704abb0ff1e2877fd629ca73abd9ed4f2a38a2fb3a6eb9e23875281e2ee977037c0e5cdc97c1aaa03d538fb9ed87"} build_url:https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/ehNlczAfRMOYxZntbQ27Ig/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e684fa7f2307a992c18e3e35e4b22491da3bb03c37a9a8c163a3bd13e6b6515ebcd7cb4c77c6ca854bd975403b292b4054ef0601e3c15e3a93bf7c45a3fa5412", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c6f5adb538dc3c0eee2733f914566289f9034cfcf03cc078f66bd8f50605789f35629461362594739536d1ef0a927563f8b1714145ff2449e089b3c6409803a8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa5d216582a34e8f7f0737e6bad1474ec6bde0071782fa688fa0885ea4688b597fc07bc56b7a9fcba7e230f6140932cdf973f8e3aaeb1d9464c2e5a5e557a0af", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e7230380c2e215d77dce23a5f67123f7dd07704abb0ff1e2877fd629ca73abd9ed4f2a38a2fb3a6eb9e23875281e2ee977037c0e5cdc97c1aaa03d538fb9ed87"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 14:32:08.246491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:32:08.246830) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1495743604.383574-1458713537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 14:32:08.331862) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 14:32:08.332184) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 14:32:08.332459) ========= ========= Total master_lag: 0.20 =========