builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1497172548.74 results: success (0) revision: 799d43edb324395cf02da6b028e803712334615f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:48.736210) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:48.737313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:48.737636) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:48.800270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:48.800572) ========= 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=0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-11 02:15:49-- 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-06-11 02:15:49 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.170575 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:49.008235) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:49.008563) ========= 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=0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014830 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:49.058151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:49.061537) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 799d43edb324395cf02da6b028e803712334615f --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 799d43edb324395cf02da6b028e803712334615f --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=0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-11 02:15:49,396 truncating revision to first 12 chars 2017-06-11 02:15:49,396 Setting DEBUG logging. 2017-06-11 02:15:49,396 attempt 1/10 2017-06-11 02:15:49,396 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/799d43edb324?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-11 02:15:49,994 unpacking tar archive at: mozilla-central-799d43edb324/testing/mozharness/ program finished with exit code 0 elapsedTime=0.956145 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:50.042157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:50.042436) ========= script_repo_revision: 799d43edb324395cf02da6b028e803712334615f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:50.042785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:50.043046) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-11 02:15:50.104931) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-06-11 02:15:50.105209) ========= /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=0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:15:50 INFO - MultiFileLogger online at 20170611 02:15:50 in /builds/slave/test 02:15:50 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 02:15:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:15:50 INFO - {'append_to_log': False, 02:15:50 INFO - 'base_work_dir': '/builds/slave/test', 02:15:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:15:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:15:50 INFO - 'branch': 'Firefox-Non-PGO', 02:15:50 INFO - 'buildbot_json_path': 'buildprops.json', 02:15:50 INFO - 'config_files': ('talos/linux_config.py',), 02:15:50 INFO - 'default_actions': ('clobber', 02:15:50 INFO - 'read-buildbot-config', 02:15:50 INFO - 'download-and-extract', 02:15:50 INFO - 'populate-webroot', 02:15:50 INFO - 'create-virtualenv', 02:15:50 INFO - 'install', 02:15:50 INFO - 'setup-mitmproxy', 02:15:50 INFO - 'run-tests'), 02:15:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:15:50 INFO - 'download_minidump_stackwalk': True, 02:15:50 INFO - 'download_symbols': 'ondemand', 02:15:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:15:50 INFO - 'tooltool.py': '/tools/tooltool.py', 02:15:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:15:50 INFO - '/tools/misc-python/virtualenv.py')}, 02:15:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:15:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:15:50 INFO - 'gecko_profile': False, 02:15:50 INFO - 'gecko_profile_interval': 0, 02:15:50 INFO - 'installer_path': 'installer.exe', 02:15:50 INFO - 'log_level': 'info', 02:15:50 INFO - 'log_name': 'talos', 02:15:50 INFO - 'log_to_console': True, 02:15:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:15:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:15:50 INFO - 'opt_config_files': (), 02:15:50 INFO - 'pip_index': False, 02:15:50 INFO - 'suite': 'dromaeojs-e10s', 02:15:50 INFO - 'system_bits': '32', 02:15:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:15:50 INFO - 'title': 'talos-linux64-ix-017', 02:15:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:15:50 INFO - 'use_talos_json': True, 02:15:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:15:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:15:50 INFO - 'work_dir': 'build'} 02:15:50 INFO - [mozharness: 2017-06-11 09:15:50.637456Z] Running clobber step. 02:15:50 INFO - Running pre-action listener: _resource_record_pre_action 02:15:50 INFO - Running main action method: clobber 02:15:50 INFO - rmtree: /builds/slave/test/build 02:15:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:15:51 INFO - Running post-action listener: _resource_record_post_action 02:15:51 INFO - [mozharness: 2017-06-11 09:15:51.630433Z] Finished clobber step (success) 02:15:51 INFO - [mozharness: 2017-06-11 09:15:51.630534Z] Running read-buildbot-config step. 02:15:51 INFO - Running pre-action listener: _resource_record_pre_action 02:15:51 INFO - Running main action method: read_buildbot_config 02:15:51 INFO - Using buildbot properties: 02:15:51 INFO - { 02:15:51 INFO - "project": "", 02:15:51 INFO - "product": "firefox", 02:15:51 INFO - "who": "archaeopteryx@coole-files.de", 02:15:51 INFO - "installer_path": "public/build/target.tar.bz2", 02:15:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:15:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:15:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:15:51 INFO - "stage_platform": "linux64", 02:15:51 INFO - "basedir": "/builds/slave/test", 02:15:51 INFO - "buildnumber": 906, 02:15:51 INFO - "platform": "ubuntu64_hw", 02:15:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:15:51 INFO - "slavebuilddir": "test", 02:15:51 INFO - "taskId": "a388ioNjSTGQfocX-ZA4Fg", 02:15:51 INFO - "branch": "mozilla-central", 02:15:51 INFO - "script_repo_revision": "production", 02:15:51 INFO - "revision": "799d43edb324395cf02da6b028e803712334615f", 02:15:51 INFO - "slavename": "talos-linux64-ix-017", 02:15:51 INFO - "repo_path": "mozilla-central" 02:15:51 INFO - } 02:15:51 INFO - Finding installer, test and symbols from parent task. 02:15:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a388ioNjSTGQfocX-ZA4Fg'}, attempt #1 02:15:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a388ioNjSTGQfocX-ZA4Fg'}, attempt #1 02:15:52 INFO - Task dependencies: YW3tuiWxRdOdlOvy6x92Rw 02:15:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw'}, attempt #1 02:15:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.tar.bz2 02:15:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/test_packages.json 02:15:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.crashreporter-symbols.zip 02:15:52 INFO - Running post-action listener: _resource_record_post_action 02:15:52 INFO - [mozharness: 2017-06-11 09:15:52.973837Z] Finished read-buildbot-config step (success) 02:15:52 INFO - [mozharness: 2017-06-11 09:15:52.974059Z] Running download-and-extract step. 02:15:52 INFO - Running pre-action listener: _resource_record_pre_action 02:15:52 INFO - Running main action method: download_and_extract 02:15:52 INFO - mkdir: /builds/slave/test/build/tests 02:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:15:52 INFO - trying https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.test_packages.json 02:15:52 INFO - Downloading https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:15:53 INFO - Downloaded 989 bytes. 02:15:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:15:53 INFO - Using the following test package requirements: 02:15:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:15:53 INFO - u'common': [u'target.common.tests.zip'], 02:15:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:15:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:15:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:15:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:15:53 INFO - u'mozbase': [u'target.common.tests.zip'], 02:15:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:15:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:15:53 INFO - u'web-platform': [u'target.common.tests.zip', 02:15:53 INFO - u'target.web-platform.tests.tar.gz'], 02:15:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:15:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:15:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.common.tests.zip 02:15:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:15:53 INFO - Fetch https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.common.tests.zip into memory 02:15:55 INFO - Content-Length response header: 67876940 02:15:55 INFO - Bytes received: 67876940 02:16:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:16:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.common.tests.zip 02:16:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:16:07 INFO - Fetch https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.common.tests.zip into memory 02:16:08 INFO - Content-Length response header: 67876940 02:16:08 INFO - Bytes received: 67876940 02:16:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.talos.tests.zip 02:16:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:16:20 INFO - Fetch https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.talos.tests.zip into memory 02:16:21 INFO - Content-Length response header: 14450010 02:16:21 INFO - Bytes received: 14450010 02:16:21 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')]} 02:16:21 INFO - trying https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.tar.bz2 02:16:21 INFO - Downloading https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:16:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:16:23 INFO - Downloaded 59392502 bytes. 02:16:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.tar.bz2 02:16:23 INFO - mkdir: /builds/slave/test/properties 02:16:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:16:23 INFO - Writing to file /builds/slave/test/properties/build_url 02:16:23 INFO - Contents: 02:16:23 INFO - build_url:https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.tar.bz2 02:16:23 INFO - Running post-action listener: _resource_record_post_action 02:16:23 INFO - Running post-action listener: set_extra_try_arguments 02:16:23 INFO - [mozharness: 2017-06-11 09:16:23.070735Z] Finished download-and-extract step (success) 02:16:23 INFO - [mozharness: 2017-06-11 09:16:23.070831Z] Running populate-webroot step. 02:16:23 INFO - Running pre-action listener: _resource_record_pre_action 02:16:23 INFO - Running main action method: populate_webroot 02:16:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:16:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:16:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:16:23 INFO - '--tppagecycles', 02:16:23 INFO - '7'], 02:16:23 INFO - 'tests': ['tsvgm']}}, 02:16:23 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:16:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:16:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:16:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:16:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:16:23 INFO - 'talos_options': ['--disable-e10s'], 02:16:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:16:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:16:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:16:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:16:23 INFO - 'talos_options': ['--disable-e10s'], 02:16:23 INFO - 'tests': ['damp', 'tps']}, 02:16:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:16:23 INFO - 'tests': ['damp', 'tps']}, 02:16:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:16:23 INFO - 'tests': ['dromaeo_dom']}, 02:16:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:16:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:16:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:16:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:16:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:16:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:16:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:16:23 INFO - 'tests': ['a11yr', 02:16:23 INFO - 'ts_paint', 02:16:23 INFO - 'tpaint', 02:16:23 INFO - 'sessionrestore', 02:16:23 INFO - 'sessionrestore_no_auto_restore', 02:16:23 INFO - 'tabpaint']}, 02:16:23 INFO - 'other-e10s': {'tests': ['a11yr', 02:16:23 INFO - 'ts_paint', 02:16:23 INFO - 'tpaint', 02:16:23 INFO - 'sessionrestore', 02:16:23 INFO - 'sessionrestore_no_auto_restore', 02:16:23 INFO - 'tabpaint']}, 02:16:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:16:23 INFO - 'ts_paint', 02:16:23 INFO - 'tpaint', 02:16:23 INFO - 'sessionrestore', 02:16:23 INFO - 'sessionrestore_no_auto_restore', 02:16:23 INFO - 'tabpaint']}, 02:16:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:16:23 INFO - 'ts_paint', 02:16:23 INFO - 'tpaint', 02:16:23 INFO - 'sessionrestore', 02:16:23 INFO - 'sessionrestore_no_auto_restore', 02:16:23 INFO - 'tabpaint']}, 02:16:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:16:23 INFO - 'tests': ['a11yr', 02:16:23 INFO - 'ts_paint', 02:16:23 INFO - 'tpaint', 02:16:23 INFO - 'sessionrestore', 02:16:23 INFO - 'sessionrestore_no_auto_restore', 02:16:23 INFO - 'tabpaint']}, 02:16:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:16:23 INFO - 'tests': ['a11yr', 02:16:23 INFO - 'ts_paint', 02:16:23 INFO - 'tpaint', 02:16:23 INFO - 'sessionrestore', 02:16:23 INFO - 'sessionrestore_no_auto_restore', 02:16:23 INFO - 'tabpaint']}, 02:16:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:16:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:16:23 INFO - 'bloom_basic_ref']}, 02:16:23 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:16:23 INFO - 'talos_options': ['--mitmproxy', 02:16:23 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:16:23 INFO - '--firstNonBlankPaint'], 02:16:23 INFO - 'tests': ['quantum_pageload_google', 02:16:23 INFO - 'quantum_pageload_youtube', 02:16:23 INFO - 'quantum_pageload_amazon', 02:16:23 INFO - 'quantum_pageload_facebook']}, 02:16:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:16:23 INFO - 'tests': ['tsvgx', 02:16:23 INFO - 'tsvgr_opacity', 02:16:23 INFO - 'tart', 02:16:23 INFO - 'tscrollx', 02:16:23 INFO - 'cart', 02:16:23 INFO - 'tsvg_static']}, 02:16:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:16:23 INFO - 'tsvgr_opacity', 02:16:23 INFO - 'tart', 02:16:23 INFO - 'tscrollx', 02:16:23 INFO - 'cart', 02:16:23 INFO - 'tsvg_static']}, 02:16:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:16:23 INFO - 'talos_options': ['--disable-e10s'], 02:16:23 INFO - 'tests': ['tp5o']}, 02:16:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:16:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:16:23 INFO - 'talos_options': ['--disable-e10s', 02:16:23 INFO - '--xperf_path', 02:16:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:16:23 INFO - 'tests': ['tp5n']}, 02:16:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:16:23 INFO - 'talos_options': ['--xperf_path', 02:16:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:16:23 INFO - 'tests': ['tp5n']}}, 02:16:23 INFO - 'talos.zip': {'path': '', 02:16:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:16:23 INFO - Running post-action listener: _resource_record_post_action 02:16:23 INFO - [mozharness: 2017-06-11 09:16:23.085647Z] Finished populate-webroot step (success) 02:16:23 INFO - [mozharness: 2017-06-11 09:16:23.085735Z] Running create-virtualenv step. 02:16:23 INFO - Running pre-action listener: _resource_record_pre_action 02:16:23 INFO - Running main action method: create_virtualenv 02:16:23 INFO - Creating virtualenv /builds/slave/test/build/venv 02:16:23 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 02:16:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:16:23 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:16:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:16:23 INFO - Using real prefix '/usr' 02:16:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:16:23 INFO - Installing distribute.............................................................................................................................................................................................done. 02:16:25 INFO - Installing pip.................done. 02:16:25 INFO - Return code: 0 02:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:16:26 INFO - Reading from file tmpfile_stdout 02:16:26 INFO - Output received: 02:16:26 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) 02:16:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:26 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 0x19413b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd140>, '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 0x1cbda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbded0>, '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': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', '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 02:16:26 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 02:16:26 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 02:16:26 INFO - Using env: {'DISPLAY': ':0', 02:16:26 INFO - 'HOME': '/home/cltbld', 02:16:26 INFO - 'LANG': 'en_US.UTF-8', 02:16:26 INFO - 'LANGUAGE': 'en_US:en', 02:16:26 INFO - 'LOGNAME': 'cltbld', 02:16:26 INFO - 'MAIL': '/var/mail/cltbld', 02:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:26 INFO - 'MOZ_NO_REMOTE': '1', 02:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:26 INFO - 'NO_EM_RESTART': '1', 02:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:26 INFO - 'PWD': '/builds/slave/test', 02:16:26 INFO - 'SHELL': '/bin/bash', 02:16:26 INFO - 'SHLVL': '1', 02:16:26 INFO - 'TERM': 'linux', 02:16:26 INFO - 'TMOUT': '86400', 02:16:26 INFO - 'USER': 'cltbld', 02:16:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', 02:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:26 INFO - '_': '/tools/buildbot/bin/python'} 02:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:26 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 02:16:26 INFO - Cleaning up... 02:16:26 INFO - Return code: 0 02:16:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:26 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 0x19413b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd140>, '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 0x1cbda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbded0>, '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': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', '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 02:16:26 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 02:16:26 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 02:16:26 INFO - Using env: {'DISPLAY': ':0', 02:16:26 INFO - 'HOME': '/home/cltbld', 02:16:26 INFO - 'LANG': 'en_US.UTF-8', 02:16:26 INFO - 'LANGUAGE': 'en_US:en', 02:16:26 INFO - 'LOGNAME': 'cltbld', 02:16:26 INFO - 'MAIL': '/var/mail/cltbld', 02:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:26 INFO - 'MOZ_NO_REMOTE': '1', 02:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:26 INFO - 'NO_EM_RESTART': '1', 02:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:26 INFO - 'PWD': '/builds/slave/test', 02:16:26 INFO - 'SHELL': '/bin/bash', 02:16:26 INFO - 'SHLVL': '1', 02:16:26 INFO - 'TERM': 'linux', 02:16:26 INFO - 'TMOUT': '86400', 02:16:26 INFO - 'USER': 'cltbld', 02:16:26 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', 02:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:26 INFO - '_': '/tools/buildbot/bin/python'} 02:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:26 INFO - Downloading/unpacking psutil>=3.1.1 02:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:16:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:16:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:16:27 INFO - Installing collected packages: psutil 02:16:27 INFO - Running setup.py install for psutil 02:16:27 INFO - building 'psutil._psutil_linux' extension 02:16:27 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 02:16:28 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 02:16:28 INFO - building 'psutil._psutil_posix' extension 02:16:28 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 02:16:28 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 02:16:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:16:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:16:28 INFO - Successfully installed psutil 02:16:28 INFO - Cleaning up... 02:16:28 INFO - Return code: 0 02:16:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19413b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd140>, '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 0x1cbda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbded0>, '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': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', '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 02:16:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:16:29 INFO - Using env: {'DISPLAY': ':0', 02:16:29 INFO - 'HOME': '/home/cltbld', 02:16:29 INFO - 'LANG': 'en_US.UTF-8', 02:16:29 INFO - 'LANGUAGE': 'en_US:en', 02:16:29 INFO - 'LOGNAME': 'cltbld', 02:16:29 INFO - 'MAIL': '/var/mail/cltbld', 02:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:29 INFO - 'MOZ_NO_REMOTE': '1', 02:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:29 INFO - 'NO_EM_RESTART': '1', 02:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:29 INFO - 'PWD': '/builds/slave/test', 02:16:29 INFO - 'SHELL': '/bin/bash', 02:16:29 INFO - 'SHLVL': '1', 02:16:29 INFO - 'TERM': 'linux', 02:16:29 INFO - 'TMOUT': '86400', 02:16:29 INFO - 'USER': 'cltbld', 02:16:29 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', 02:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:29 INFO - '_': '/tools/buildbot/bin/python'} 02:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:16:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:16:30 INFO - Installing collected packages: mozsystemmonitor 02:16:30 INFO - Running setup.py install for mozsystemmonitor 02:16:30 INFO - Successfully installed mozsystemmonitor 02:16:30 INFO - Cleaning up... 02:16:30 INFO - Return code: 0 02:16:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x19413b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd140>, '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 0x1cbda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbded0>, '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': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', '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 02:16:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:16:30 INFO - Using env: {'DISPLAY': ':0', 02:16:30 INFO - 'HOME': '/home/cltbld', 02:16:30 INFO - 'LANG': 'en_US.UTF-8', 02:16:30 INFO - 'LANGUAGE': 'en_US:en', 02:16:30 INFO - 'LOGNAME': 'cltbld', 02:16:30 INFO - 'MAIL': '/var/mail/cltbld', 02:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:30 INFO - 'MOZ_NO_REMOTE': '1', 02:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:30 INFO - 'NO_EM_RESTART': '1', 02:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:30 INFO - 'PWD': '/builds/slave/test', 02:16:30 INFO - 'SHELL': '/bin/bash', 02:16:30 INFO - 'SHLVL': '1', 02:16:30 INFO - 'TERM': 'linux', 02:16:30 INFO - 'TMOUT': '86400', 02:16:30 INFO - 'USER': 'cltbld', 02:16:30 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', 02:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:30 INFO - '_': '/tools/buildbot/bin/python'} 02:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:30 INFO - Downloading/unpacking jsonschema==2.5.1 02:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:16:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:32 INFO - Downloading functools32-3.2.3-2.tar.gz 02:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:16:32 INFO - warning: no files found matching '*.txt' 02:16:32 INFO - no previously-included directories found matching 'build' 02:16:32 INFO - no previously-included directories found matching 'dist' 02:16:32 INFO - no previously-included directories found matching '.git*' 02:16:32 INFO - Installing collected packages: jsonschema, functools32 02:16:32 INFO - Running setup.py install for functools32 02:16:32 INFO - warning: no files found matching '*.txt' 02:16:32 INFO - no previously-included directories found matching 'build' 02:16:32 INFO - no previously-included directories found matching 'dist' 02:16:32 INFO - no previously-included directories found matching '.git*' 02:16:32 INFO - Successfully installed jsonschema functools32 02:16:32 INFO - Cleaning up... 02:16:32 INFO - Return code: 0 02:16:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:32 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 0x19413b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd140>, '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 0x1cbda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbded0>, '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': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', '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 02:16:32 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 02:16:32 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 02:16:32 INFO - Using env: {'DISPLAY': ':0', 02:16:32 INFO - 'HOME': '/home/cltbld', 02:16:32 INFO - 'LANG': 'en_US.UTF-8', 02:16:32 INFO - 'LANGUAGE': 'en_US:en', 02:16:32 INFO - 'LOGNAME': 'cltbld', 02:16:32 INFO - 'MAIL': '/var/mail/cltbld', 02:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:32 INFO - 'MOZ_NO_REMOTE': '1', 02:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:32 INFO - 'NO_EM_RESTART': '1', 02:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:32 INFO - 'PWD': '/builds/slave/test', 02:16:32 INFO - 'SHELL': '/bin/bash', 02:16:32 INFO - 'SHLVL': '1', 02:16:32 INFO - 'TERM': 'linux', 02:16:32 INFO - 'TMOUT': '86400', 02:16:32 INFO - 'USER': 'cltbld', 02:16:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', 02:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:32 INFO - '_': '/tools/buildbot/bin/python'} 02:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:16:32 INFO - Cleaning up... 02:16:32 INFO - Return code: 0 02:16:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:32 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 0x19413b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd140>, '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 0x1cbda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbded0>, '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': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', '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 02:16:32 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 02:16:32 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 02:16:32 INFO - Using env: {'DISPLAY': ':0', 02:16:32 INFO - 'HOME': '/home/cltbld', 02:16:32 INFO - 'LANG': 'en_US.UTF-8', 02:16:32 INFO - 'LANGUAGE': 'en_US:en', 02:16:32 INFO - 'LOGNAME': 'cltbld', 02:16:32 INFO - 'MAIL': '/var/mail/cltbld', 02:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:32 INFO - 'MOZ_NO_REMOTE': '1', 02:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:32 INFO - 'NO_EM_RESTART': '1', 02:16:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:32 INFO - 'PWD': '/builds/slave/test', 02:16:32 INFO - 'SHELL': '/bin/bash', 02:16:32 INFO - 'SHLVL': '1', 02:16:32 INFO - 'TERM': 'linux', 02:16:32 INFO - 'TMOUT': '86400', 02:16:32 INFO - 'USER': 'cltbld', 02:16:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', 02:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:32 INFO - '_': '/tools/buildbot/bin/python'} 02:16:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:32 INFO - Downloading/unpacking blobuploader==1.2.4 02:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:33 INFO - Downloading blobuploader-1.2.4.tar.gz 02:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:16:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:16:33 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 02:16:33 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 02:16:33 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 02:16:33 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 02:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:16:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:16:34 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 02:16:34 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 02:16:34 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 02:16:34 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 02:16:34 INFO - Downloading docopt-0.6.1.tar.gz 02:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:16:34 INFO - Installing collected packages: blobuploader, requests, docopt 02:16:34 INFO - Running setup.py install for blobuploader 02:16:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:16:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:16:34 INFO - Running setup.py install for requests 02:16:34 INFO - Running setup.py install for docopt 02:16:35 INFO - Successfully installed blobuploader requests docopt 02:16:35 INFO - Cleaning up... 02:16:35 INFO - Return code: 0 02:16:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:16:35 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')]} 02:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:35 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')]} 02:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:35 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 0x19413b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd140>, '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 0x1cbda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbded0>, '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': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', '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 02:16:35 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 02:16:35 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 02:16:35 INFO - Using env: {'DISPLAY': ':0', 02:16:35 INFO - 'HOME': '/home/cltbld', 02:16:35 INFO - 'LANG': 'en_US.UTF-8', 02:16:35 INFO - 'LANGUAGE': 'en_US:en', 02:16:35 INFO - 'LOGNAME': 'cltbld', 02:16:35 INFO - 'MAIL': '/var/mail/cltbld', 02:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:35 INFO - 'MOZ_NO_REMOTE': '1', 02:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:35 INFO - 'NO_EM_RESTART': '1', 02:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:35 INFO - 'PWD': '/builds/slave/test', 02:16:35 INFO - 'SHELL': '/bin/bash', 02:16:35 INFO - 'SHLVL': '1', 02:16:35 INFO - 'TERM': 'linux', 02:16:35 INFO - 'TMOUT': '86400', 02:16:35 INFO - 'USER': 'cltbld', 02:16:35 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', 02:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:35 INFO - '_': '/tools/buildbot/bin/python'} 02:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:16:35 INFO - Running setup.py (path:/tmp/pip-ac5jKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:16:35 INFO - Running setup.py (path:/tmp/pip-2y66ZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:16:35 INFO - Running setup.py (path:/tmp/pip-hdNG99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:16:35 INFO - Running setup.py (path:/tmp/pip-ITiWKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:16:35 INFO - Running setup.py (path:/tmp/pip-OT3qEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:16:35 INFO - Running setup.py (path:/tmp/pip-oVSrVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:16:35 INFO - Running setup.py (path:/tmp/pip-xQDUhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:16:35 INFO - Running setup.py (path:/tmp/pip-mT_ylv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:16:35 INFO - Running setup.py (path:/tmp/pip-MzfKua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:16:35 INFO - Running setup.py (path:/tmp/pip-t4LB50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:16:36 INFO - Running setup.py (path:/tmp/pip-yixsOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:16:36 INFO - Running setup.py (path:/tmp/pip-rV16bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:16:36 INFO - Running setup.py (path:/tmp/pip-_e8URf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:16:36 INFO - Running setup.py (path:/tmp/pip-3U5WMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:36 INFO - Running setup.py (path:/tmp/pip-QT9Rou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:16:36 INFO - Running setup.py (path:/tmp/pip-2MkaJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:16:36 INFO - Running setup.py (path:/tmp/pip-HpNbOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:16:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:16:36 INFO - Running setup.py install for manifestparser 02:16:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:16:36 INFO - Running setup.py install for mozcrash 02:16:36 INFO - Running setup.py install for mozdebug 02:16:36 INFO - Running setup.py install for mozdevice 02:16:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:16:36 INFO - Running setup.py install for mozfile 02:16:37 INFO - Running setup.py install for mozhttpd 02:16:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:16:37 INFO - Running setup.py install for mozinfo 02:16:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:16:37 INFO - Running setup.py install for mozInstall 02:16:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:16:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:16:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:16:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:16:37 INFO - Running setup.py install for mozleak 02:16:37 INFO - Running setup.py install for mozlog 02:16:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:16:37 INFO - Running setup.py install for moznetwork 02:16:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:16:37 INFO - Running setup.py install for mozprocess 02:16:37 INFO - Running setup.py install for mozprofile 02:16:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:16:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:16:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:16:37 INFO - Running setup.py install for mozrunner 02:16:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:16:37 INFO - Running setup.py install for mozscreenshot 02:16:38 INFO - Running setup.py install for moztest 02:16:38 INFO - Running setup.py install for mozversion 02:16:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:16:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:16:38 INFO - Cleaning up... 02:16:38 INFO - Return code: 0 02:16:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:16: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')]} 02:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16: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')]} 02:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:38 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 0x19413b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd140>, '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 0x1cbda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbded0>, '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': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', '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 02:16:38 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 02:16:38 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 02:16:38 INFO - Using env: {'DISPLAY': ':0', 02:16:38 INFO - 'HOME': '/home/cltbld', 02:16:38 INFO - 'LANG': 'en_US.UTF-8', 02:16:38 INFO - 'LANGUAGE': 'en_US:en', 02:16:38 INFO - 'LOGNAME': 'cltbld', 02:16:38 INFO - 'MAIL': '/var/mail/cltbld', 02:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:38 INFO - 'MOZ_NO_REMOTE': '1', 02:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:38 INFO - 'NO_EM_RESTART': '1', 02:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:38 INFO - 'PWD': '/builds/slave/test', 02:16:38 INFO - 'SHELL': '/bin/bash', 02:16:38 INFO - 'SHLVL': '1', 02:16:38 INFO - 'TERM': 'linux', 02:16:38 INFO - 'TMOUT': '86400', 02:16:38 INFO - 'USER': 'cltbld', 02:16:38 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', 02:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:38 INFO - '_': '/tools/buildbot/bin/python'} 02:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:16:38 INFO - Running setup.py (path:/tmp/pip-d9Qdgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:16:38 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)) 02:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:16:38 INFO - Running setup.py (path:/tmp/pip-s3pBdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:16:38 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)) 02:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:16:38 INFO - Running setup.py (path:/tmp/pip-wyhYNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:16:38 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)) 02:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:16:38 INFO - Running setup.py (path:/tmp/pip-2Xe99R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:16:38 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)) 02:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:16:38 INFO - Running setup.py (path:/tmp/pip-QVXPCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:16:38 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)) 02:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:16:38 INFO - Running setup.py (path:/tmp/pip-UT0oM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:16:38 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)) 02:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:16:38 INFO - Running setup.py (path:/tmp/pip-gMId4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:16:39 INFO - Running setup.py (path:/tmp/pip-rmWtJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:16:39 INFO - Running setup.py (path:/tmp/pip-YqyHMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:16:39 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)) 02:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:16:39 INFO - Running setup.py (path:/tmp/pip-sf9uZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:16:39 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)) 02:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:16:39 INFO - Running setup.py (path:/tmp/pip-nGT0Na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:16:39 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)) 02:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:16:39 INFO - Running setup.py (path:/tmp/pip-thRGYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:16:39 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)) 02:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:16:39 INFO - Running setup.py (path:/tmp/pip-T2uIKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:16:39 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)) 02:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:16:39 INFO - Running setup.py (path:/tmp/pip-QRJdid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:16:39 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)) 02:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:39 INFO - Running setup.py (path:/tmp/pip-VEgcmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:16:39 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)) 02:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:16:39 INFO - Running setup.py (path:/tmp/pip-MITPyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:16:39 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)) 02:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:16:39 INFO - Running setup.py (path:/tmp/pip-lTaGM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:16:39 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)) 02:16:39 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)) 02:16:39 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)) 02:16:39 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)) 02:16:39 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)) 02:16:39 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)) 02:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:16:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:40 INFO - Downloading blessings-1.6.tar.gz 02:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:16:40 INFO - Installing collected packages: blessings 02:16:40 INFO - Running setup.py install for blessings 02:16:41 INFO - Successfully installed blessings 02:16:41 INFO - Cleaning up... 02:16:41 INFO - Return code: 0 02:16:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:16:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:16:41 INFO - Reading from file tmpfile_stdout 02:16:41 INFO - Current package versions: 02:16:41 INFO - argparse == 1.2.1 02:16:41 INFO - blessings == 1.6 02:16:41 INFO - blobuploader == 1.2.4 02:16:41 INFO - docopt == 0.6.1 02:16:41 INFO - functools32 == 3.2.3-2 02:16:41 INFO - jsonschema == 2.5.1 02:16:41 INFO - manifestparser == 1.1 02:16:41 INFO - mozInstall == 1.13 02:16:41 INFO - mozcrash == 1.0 02:16:41 INFO - mozdebug == 0.1 02:16:41 INFO - mozdevice == 0.51 02:16:41 INFO - mozfile == 1.2 02:16:41 INFO - mozhttpd == 0.7 02:16:41 INFO - mozinfo == 0.10 02:16:41 INFO - mozleak == 0.1 02:16:41 INFO - mozlog == 3.4 02:16:41 INFO - moznetwork == 0.27 02:16:41 INFO - mozprocess == 0.25 02:16:41 INFO - mozprofile == 0.28 02:16:41 INFO - mozrunner == 6.13 02:16:41 INFO - mozscreenshot == 0.1 02:16:41 INFO - mozsystemmonitor == 0.3 02:16:41 INFO - moztest == 0.8 02:16:41 INFO - mozversion == 1.4 02:16:41 INFO - psutil == 3.1.1 02:16:41 INFO - requests == 1.2.3 02:16:41 INFO - wsgiref == 0.1.2 02:16:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16:41 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 0x19413b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd140>, '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 0x1cbda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbded0>, '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': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', '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 02:16:41 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 02:16:41 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 02:16:41 INFO - Using env: {'DISPLAY': ':0', 02:16:41 INFO - 'HOME': '/home/cltbld', 02:16:41 INFO - 'LANG': 'en_US.UTF-8', 02:16:41 INFO - 'LANGUAGE': 'en_US:en', 02:16:41 INFO - 'LOGNAME': 'cltbld', 02:16:41 INFO - 'MAIL': '/var/mail/cltbld', 02:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:41 INFO - 'MOZ_NO_REMOTE': '1', 02:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:41 INFO - 'NO_EM_RESTART': '1', 02:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:41 INFO - 'PWD': '/builds/slave/test', 02:16:41 INFO - 'SHELL': '/bin/bash', 02:16:41 INFO - 'SHLVL': '1', 02:16:41 INFO - 'TERM': 'linux', 02:16:41 INFO - 'TMOUT': '86400', 02:16:41 INFO - 'USER': 'cltbld', 02:16:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', 02:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:41 INFO - '_': '/tools/buildbot/bin/python'} 02:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:41 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)) 02:16:41 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)) 02:16:41 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)) 02:16:41 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)) 02:16:41 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)) 02:16:41 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)) 02:16:41 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)) 02:16:41 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)) 02:16:41 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)) 02:16:41 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:16:42 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:16:42 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)) 02:16:42 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)) 02:16:42 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)) 02:16:42 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)) 02:16:42 INFO - Installing collected packages: marionette-driver 02:16:42 INFO - Running setup.py install for marionette-driver 02:16:42 INFO - Successfully installed marionette-driver 02:16:42 INFO - Cleaning up... 02:16:42 INFO - Return code: 0 02:16:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:16: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')]} 02:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:16: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')]} 02:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:16: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19413b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cbf9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbd140>, '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 0x1cbda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbded0>, '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': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', '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 02:16: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', 'jsonschema'] in /builds/slave/test/build 02:16: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 jsonschema 02:16:42 INFO - Using env: {'DISPLAY': ':0', 02:16:42 INFO - 'HOME': '/home/cltbld', 02:16:42 INFO - 'LANG': 'en_US.UTF-8', 02:16:42 INFO - 'LANGUAGE': 'en_US:en', 02:16:42 INFO - 'LOGNAME': 'cltbld', 02:16:42 INFO - 'MAIL': '/var/mail/cltbld', 02:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:16:42 INFO - 'MOZ_NO_REMOTE': '1', 02:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:16:42 INFO - 'NO_EM_RESTART': '1', 02:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:16:42 INFO - 'PWD': '/builds/slave/test', 02:16:42 INFO - 'SHELL': '/bin/bash', 02:16:42 INFO - 'SHLVL': '1', 02:16:42 INFO - 'TERM': 'linux', 02:16:42 INFO - 'TMOUT': '86400', 02:16:42 INFO - 'USER': 'cltbld', 02:16:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', 02:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:16:42 INFO - '_': '/tools/buildbot/bin/python'} 02:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:16:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:16:43 INFO - Cleaning up... 02:16:43 INFO - Return code: 0 02:16:43 INFO - Running post-action listener: _resource_record_post_action 02:16:43 INFO - Running post-action listener: _start_resource_monitoring 02:16:43 INFO - Starting resource monitoring. 02:16:43 INFO - [mozharness: 2017-06-11 09:16:43.114124Z] Finished create-virtualenv step (success) 02:16:43 INFO - [mozharness: 2017-06-11 09:16:43.115042Z] Running install step. 02:16:43 INFO - Running pre-action listener: _resource_record_pre_action 02:16:43 INFO - Running main action method: install 02:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:16:43 INFO - Reading from file tmpfile_stdout 02:16:43 INFO - Detecting whether we're running mozinstall >=1.0... 02:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:16:43 INFO - Reading from file tmpfile_stdout 02:16:43 INFO - Output received: 02:16:43 INFO - Usage: mozinstall [options] installer 02:16:43 INFO - Options: 02:16:43 INFO - -h, --help show this help message and exit 02:16:43 INFO - -d DEST, --destination=DEST 02:16:43 INFO - Directory to install application into. [default: 02:16:43 INFO - "/builds/slave/test"] 02:16:43 INFO - --app=APP Application being installed. [default: firefox] 02:16:43 INFO - mkdir: /builds/slave/test/build/application 02:16:43 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'] 02:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:17:00 INFO - Reading from file tmpfile_stdout 02:17:00 INFO - Output received: 02:17:00 INFO - /builds/slave/test/build/application/firefox/firefox 02:17:00 INFO - Running post-action listener: _resource_record_post_action 02:17:00 INFO - [mozharness: 2017-06-11 09:17:00.621047Z] Finished install step (success) 02:17:00 INFO - [mozharness: 2017-06-11 09:17:00.621202Z] Running setup-mitmproxy step. 02:17:00 INFO - Running pre-action listener: _resource_record_pre_action 02:17:00 INFO - Running main action method: setup_mitmproxy 02:17:00 INFO - Skipping: mitmproxy is not required 02:17:00 INFO - Running post-action listener: _resource_record_post_action 02:17:00 INFO - [mozharness: 2017-06-11 09:17:00.621731Z] Finished setup-mitmproxy step (success) 02:17:00 INFO - [mozharness: 2017-06-11 09:17:00.621824Z] Running run-tests step. 02:17:00 INFO - Running pre-action listener: _resource_record_pre_action 02:17:00 INFO - Running main action method: run_tests 02:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:17:00 INFO - Python 2.7.3 02:17:00 INFO - Return code: 0 02:17:00 INFO - grabbing minidump binary from tooltool 02:17:00 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')]} 02:17:00 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 0x1cbd140>, '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 0x1cbda40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbded0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:17:00 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 02:17:00 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 02:17:00 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 02:17:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:17:00 INFO - Return code: 0 02:17:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:17:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:17:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:17:00 INFO - ENV: RUST_BACKTRACE is now 1 02:17:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:17:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:17:00 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/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 02:17:00 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/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 02:17:00 INFO - Using env: {'DISPLAY': ':0', 02:17:00 INFO - 'HOME': '/home/cltbld', 02:17:00 INFO - 'LANG': 'en_US.UTF-8', 02:17:00 INFO - 'LANGUAGE': 'en_US:en', 02:17:00 INFO - 'LOGNAME': 'cltbld', 02:17:00 INFO - 'MAIL': '/var/mail/cltbld', 02:17:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:17:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:17:00 INFO - 'MOZ_NO_REMOTE': '1', 02:17:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:17:00 INFO - 'NO_EM_RESTART': '1', 02:17:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:17:00 INFO - 'PWD': '/builds/slave/test', 02:17:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:17:00 INFO - 'RUST_BACKTRACE': '1', 02:17:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:17:00 INFO - 'SHELL': '/bin/bash', 02:17:00 INFO - 'SHLVL': '1', 02:17:00 INFO - 'TERM': 'linux', 02:17:00 INFO - 'TMOUT': '86400', 02:17:00 INFO - 'USER': 'cltbld', 02:17:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442', 02:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:17:00 INFO - '_': '/tools/buildbot/bin/python'} 02:17:00 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/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 02:17:01 INFO - mozversion application_buildid: 20170611083556 02:17:01 INFO - mozversion application_changeset: 799d43edb324395cf02da6b028e803712334615f 02:17:01 INFO - mozversion application_display_name: Nightly 02:17:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:17:01 INFO - mozversion application_name: Firefox 02:17:01 INFO - mozversion application_remotingname: firefox 02:17:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:17:01 INFO - mozversion application_vendor: Mozilla 02:17:01 INFO - mozversion application_version: 55.0a1 02:17:01 INFO - mozversion platform_buildid: 20170611083556 02:17:01 INFO - mozversion platform_changeset: 799d43edb324395cf02da6b028e803712334615f 02:17:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:17:01 INFO - mozversion platform_version: 55.0a1 02:17:01 INFO - using testdate: 1497172621 02:17:01 INFO - actual date: 1497172621 02:17:01 INFO - starting webserver on 'localhost:47603' 02:17:01 INFO - SUITE-START | Running 2 tests 02:17:01 INFO - TEST-START | dromaeo_css 02:17:01 INFO - operating with platform_type : linux_ 02:17:01 INFO - Initialising browser for dromaeo_css test... 02:17:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47603/getInfo.html -profile /tmp/tmpMRUBHC/profile 02:17:01 INFO - TEST-INFO | started process 3324 (/builds/slave/test/build/application/firefox/firefox http://localhost:47603/getInfo.html) 02:17:37 INFO - TEST-INFO | 3324: killed by SIGTERM 02:17:37 INFO - Browser initialized. 02:17:37 INFO - Running cycle 1/1 for dromaeo_css test... 02:17:37 INFO - TEST-INFO | started process 3530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMRUBHC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:17:49 INFO - PID 3530 | RSS: Main: 184324096 02:17:49 INFO - PID 3530 | 02:20:51 INFO - PID 3530 | Cycle 1(1): loaded http://localhost:47603/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47603/tests/dromaeo/cssquery-ext.html) 02:20:53 INFO - PID 3530 | RSS: Main: 183443456 02:20:53 INFO - PID 3530 | 02:23:54 INFO - PID 3530 | Cycle 1(1): loaded http://localhost:47603/tests/dromaeo/cssquery-ext.html (next: http://localhost:47603/tests/dromaeo/cssquery-jquery.html) 02:23:55 INFO - PID 3530 | RSS: Main: 189923328 02:23:55 INFO - PID 3530 | 02:26:57 INFO - PID 3530 | Cycle 1(1): loaded http://localhost:47603/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47603/tests/dromaeo/cssquery-mootools.html) 02:26:57 INFO - PID 3530 | RSS: Main: 188039168 02:26:57 INFO - PID 3530 | 02:29:59 INFO - PID 3530 | Cycle 1(1): loaded http://localhost:47603/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47603/tests/dromaeo/cssquery-prototype.html) 02:30:00 INFO - PID 3530 | RSS: Main: 189325312 02:30:00 INFO - PID 3530 | 02:33:02 INFO - PID 3530 | Cycle 1(1): loaded http://localhost:47603/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47603/tests/dromaeo/cssquery-yui.html) 02:33:03 INFO - PID 3530 | RSS: Main: 187875328 02:33:03 INFO - PID 3530 | 02:36:04 INFO - PID 3530 | Cycle 1(1): loaded http://localhost:47603/tests/dromaeo/cssquery-yui.html (next: http://localhost:47603/tests/dromaeo/cssquery-dojo.html) 02:36:05 INFO - PID 3530 | RSS: Main: 187023360 02:36:05 INFO - PID 3530 | 02:36:05 INFO - PID 3530 | __start_tp_report 02:36:05 INFO - PID 3530 | _x_x_mozilla_page_load 02:36:05 INFO - PID 3530 | _x_x_mozilla_page_load_details 02:36:05 INFO - PID 3530 | |i|pagename|runs| 02:36:05 INFO - PID 3530 | |0;dojo.html;3025.939481210375;3029.1972627253795;3058.801177923436;3081.8150910945346;3101.782875198737;5859.296884373881;5902.321233058189;5907.911381329283;5909.822705318842;5934.347221805598;5880.705964701759;5918.88162236755;5953.553483488745;5962.731677074531;5976.641401515912;5382.1926710993275;5431.809886653968;5452.318460192476;5454.372747134091;5563.221149039137;5538.418466061046;5591.496765291123;5606.635568688042;5614.466625670555;5656.095024796034;5580.302462192226;5588.972055139719;5600.971995140018;5623.297087864017;5631.211630371751;5516.448355164492;5589.413111623262;5617.747201375927;5637.830865074055;5640.097584386478;5246.291750613695;5356.223347614613;5442.183672449125;5480.314960629921;5523.28197334344;5788.218590490272;5846.7076646167525;5884.794032208895;5909.793157239519;5941.762329506814;6352.46004089653;6394.552381333308;6408.679566021727;6408.903866442007;6422.678866056678;6453.709583068726;6455.709493072823;6459.418652321267;6467.5472716909835;6470.57941233823;5919.822405327847;5926.199963005025;5973;5977.372375900555;5980.162777211194;6428.485721142298;6526.60840349571;6540;6592.208934927839;6625.569337993015;6116.5106791457465;6144.692765361714;6155.855290047947;6197.96901015492;6206.534509911684;6348.968255158695;6349.6507692077375;6373.872522549523;6374.617522948638;6400.199975003125;6167.599106058092;6282.591631543935;6303.46420554258;6390.904136437957;6404.295527491972;6287.245530536365;6316.052592111128;6343.936560634427;6397.136386587751;6413.551051426449;5197.532222099953;5240.868978275574;5244.475552444725;5252.553532949666;5265.973670131625;4460.598546130864;4460.843870464518;4472.08322293929;4475.820967161277;4492.011757413364;5517.503424691797;5572.944270557324;5575.4424557543925;5617.01702202113;5617.101263797773;6398.29618741938;6398.456131228804;6428.132202152649;6441.871162576816;6493.772717954944;5588.860278492989;5614.578906582023;5649.4350564944;5666.801661941895;5675.233843431167;5661;5726.312842458931;5735.77056917727;5749.942500574941;5768.855778605568;6247.937520624736;6288.717007734755;6294.716737746812;6304.211973503312;6304.401081897213;6482.189726284215;6495.545311828127;6506.056621789909;6509.283978762238;6548.246951600437;6038.6678732670125;6126.120738204555;6129.14485165794;6130.417610327012;6281.59169653971;6159.19930409044;6248.250209974832;6272.310045894857;6279.089532017923;6294.685265736786;6477.578957367756;6512.967435162794;6522.869542609216;6523.706433210422;6557.082008518906;6325.272593651604;6333.714982825876;6338.746450141943;6351.77768778109;6365;6112.868254062901;6317.526185536011;6330.905036424365;6339.270983836734;6364.490840732823;6111.908321375272;6123.231910558009;6145.7708458307625;6178.578926846761;6262.812115636538;6251.812445626639;6316.968415157895;6334.239891212899;6355.046742988588;6361.14124593174;6150.292716337678;6173.228346456693;6186.319504854372;6187.16473276102;6189.566730329014 02:36:05 INFO - PID 3530 | |1;ext.html;687.9243283238843;720.094966202627;734.5188901269669;755.8110472381903;758.9468737188399;37163.25673486532;37680.62319376806;37801.24397512048;37908.62091379085;38019.99999999996;33753.831230843876;34241.31517369651;34312;34498.310033799375;34554.30891382171;6190.84522886927;6307.243130824308;6310.9586918158675;6344.460720838734;6350.42846143847;6319.589226700273;6370.49036077115;6384.93615063848;6404.839879003039;6435.8391040223905;6331.715072821711;6385.361463853601;6386.425221730044;6416;6423.293437721847;6314.526410519229;6384.58500197488;6385.106085148037;6390.169277993878;6391.105245265643;5725.1698503716725;5747.913781293284;5757.510611598019;6874.8625027499675;7091.326323999212;34937;34992.82503587466;35236.64763352359;35344.46983295253;35381.29237415263;3418.572678415198;3451.551298331201;3461.0309113448275;3470.340635279289;3478.286951175003;27135.592966105523;27221;27308;27343.589846152325;27496.312592185157;3351.899443016689;3360.8991730247885;3383.1034775784437;3393.321335732863;3425.3663072331697;144950;147813.26093369463;167524;168969;169086;36096;41602;42246.57753422488;42279.365809512885;42520;45364;45463.318050229274;45479;45492.772536137105;45810.083798323845;15020.549383518512;15119.092854428549;15184.46854360092;15192.316345764468;15220.695586088215;12053.939730301292;12168.756624867454;12187.268763874195;12199.817002744965;12221.572244971383;13634.86365136336;13649;13680.863191368158;13749.656258593615;13827.51603693866;5390.326209223847;5407.270018547446;5493.587980901449;5644.701718604744;5684.317881854204;975.1564896364594;984.3109823123842;990.3810118675827;1016.3139880580578;1023.2325755683238;21524;21736.580788928342;21869.343919682437;21958.01188946469;22469.88765056197;1065.0946695308926;1066.7119877632995;1077.1921059205595;1093.830456279278;1119.0935342372704;11506.424678766196;11559.248648837798;11647.776983416788;11934.820977685342;12244.265344079384;209002;211257;212294;212906;213889;46529.30206046912;46872;46907;47011;51557.74221128871;1465.4431316099815;1472.3521650473758;1480.9777853332423;1485.472657206676;1494.2230040378943;25575.570320819494;27700.307492312855;27765.583516247676;27766.86116569404;27929.44141117207;35235.29529409449;35547.28905421929;35644.643553564136;35649;35680.64319356877;188380;188756;189454;190015;190226;27840.025599103934;27985.720142798313;28375.29061773472;30397.544036839023;33435;38126.80936595299;38524.80737596294;38615.22769544537;38769.80615096907;40421.59578404296;28110;29034.41931161407;29333.70666293395;29416.26459338534;30740.538891916192;29078;29582.556261655664;29921.401571968872;30313.545296821005;30686.846565767923;32416;32443.837780810944;32525.83737081394;33461.83269083639;33862.492062619574;27522.449551009267;28969.85515072411;29147.70852291535;29634.25914352072;29719.959801406847;22061.448463788533;23241.3027609172;23263.836808159187;23284.76715232826;23451.648225276294 02:36:05 INFO - PID 3530 | |2;jquery.html;476.9236922092466;483.31610770759386;486.99006053286445;506.1774616248597;511.9590432765379;19241.615167696636;19898.502537436572;19929.800701992994;20082.397528074143;20189.697154542657;22016.559668806614;24272.27183184507;24288;24636.137735179273;24656.876715616443;5936.228290322263;6036.577439579231;6071.301800292978;6075.7569697212275;6083.209182806229;6038.6074905131245;6056.061310496858;6072.848178795543;6078.939210607904;6090.573659843791;5812.418758124175;5985.371535988724;6055.122007308938;6059.697015149247;6091.878162436748;5968.910466343008;5975.432333928292;6042.425969532931;6053.092036194562;6080.30076541199;5571.832845014656;5580.386157522669;5591.133374326986;5594.328680558318;5603.7478313475585;26171.607425888626;26303.605445918325;26422.207333780018;26486.337841553923;26542.6018609721;1813.718873574585;1892.3187652445108;1903.172120127749;1938;1939.3115444017453;16760.916195419068;17006.914965425218;17078.231479583323;17125.22936467862;17194.226259818337;2250.763669814662;2296.6899468571696;2323.6049871521714;2331.7408599356327;2347.835651504395;97870.51064744702;103565;104130;115662;116075.41962290135;12981.221126732426;13031.478740850449;13054.477820887249;13184.670383240496;13521.121127126902;19552.31566895152;19558.21767129299;19586.804131958783;19593.706094408597;19679;9272.443653380818;9522.190613797766;9574.617015319449;9599.16033586571;9655.131038206595;8874.778130546789;8902.287816974627;8946.955265223633;8995;9019.549022548847;8260.297874680598;8272.214139656722;8329.333653307842;8334.458260213189;8355.540445275568;2199.973061554341;2234.273860995183;2247.775222477772;2257.7064981552294;2349.8355115141776;932.5337331334333;943.613118621362;954.8424509955779;986.3835103060587;991.5686676295691;18438.907805460887;18465.630687386176;19158.61682766365;19269.61460770777;19322.903385482983;963.7397902566267;976.097110173087;996.4868092932146;998.2413365842012;999.8850132234886;10231.795364092677;10285.43430111351;10320.62152462832;10458.52936617854;10614.044735973644;415755;417739;421432;422788;423412;100942.49528752457;104530;105471.47264263783;105888.47055764672;106635.46682266539;1065.2596445470324;1103.933763974164;1108.9500972456258;1151.5393842462913;1203.3862730007759;18187.363442279988;19789.901050494656;20264.696029559862;20590.897045514677;20614.793852061288;44621.55378446174;47084.29373559331;47539.76230118966;47739.28391074067;49328.75335623299;60072.69963650154;60161.39838601733;60179.699101504215;60683.69658151681;60766.39233607784;11073.224874259047;11146.777064458827;11193.048590869867;11210.49552770111;11230.382328971986;16260.268287926836;16634.753470560056;16852.662946741242;16999.830001699826;18215.362462313755;13626.250556219107;13650.863491365357;13705.109167904055;13989.887065675193;15318.770218446509;13246.602601921957;13272.27002514871;13335.733285334045;13343.466261349437;13883.791743124064;15298.311575978885;15473.922630386776;15529.068255904682;15583.532494025198;15608.609784755017;11449.656510304705;11516.309021458404;11546.307221566733;11547.307161569997;11562.88437115618;13768.862311376757;14870.256487175815;15008.174550399834;15050;15099.773503397677 02:36:05 INFO - PID 3530 | |3;mootools.html;1272.7836267834468;1328.9335533223343;1331.3343328335832;1344.052443027665;1359.653288411455;11804.350760708168;12203.633890983263;12333.568325108623;12392.132550721442;12404.255744655316;11856.762864742721;12190.024798016137;12213.328266945315;12233.877661223385;12270.202436841599;2490.4645501217187;2540.3522101864;2543.186180422266;2543.9618405723836;2546.719860815309;2450.779429851313;2516.358328626207;2517.2322441655288;2518.874056297187;2519.282004628681;2460.6063029915126;2477.2072936660275;2487.092211342865;2502.4869901670204;2506.2606531073284;2382.130522359335;2405.8436201646923;2411.3730430088126;2411.565918134735;2412.674288970984;2356.4580146566213;2368.5973384524673;2373.2761507740133;2384.4396566806786;2385.33210701004;11718.70703232426;11931;11987.760244795056;11991.820122698167;11994.460249288803;6785.830354241183;7055.858882822315;7083.539569927938;7084.574925504487;7103;3942.2706799242233;4086.7547947123267;4132.669386449077;4200.075983283673;4231.788410579489;1437.2669938331526;1486.7323881701288;1519.6276912156482;1531.8544738249848;1535.9462418815287;16948.23732932021;17612.119394030375;18571.350002749976;18738.531536711555;18750.34373796924;5402.648827826179;5919.4080591940465;6078.361772013964;6103.05402662588;6124.326324104345;13520.797188042186;13586.592402227949;13596.796048059286;13599.660008499668;13642.590722278348;7002.894956575656;7052.365287124184;7060.752873649398;7065.43476521877;7074.186468556079;6440.194975628046;6555.541112122106;6585.73657053722;6587.80236592903;6598;4552.499225085238;4658.208104622222;4686.671932964659;4706.976465117653;4722.598579120745;1350.4260689207047;1364.5769811358512;1370.766969615168;1392.463901397969;1401.5585090696397;858.1161403754144;860.6772460327377;867.6399294292797;872.5768002518773;891.572045418203;6614.8346291343105;6642.96678516614;6706.631135287606;6754.257031726506;6815.352541508549;666.6866572710818;679.5786612300307;702.7083760239443;704.4329314901554;713.1869668577825;4044.8786536403954;4111.527174374925;4294.162638285567;4403.9779801100785;4702.858914232578;15417.383304667912;15678;16011.95922265049;16063.759043614355;16068;15540;15744.606384840241;16022.599435013984;16359.509214723577;16371.59071023234;9678.467684277432;9824.67366905473;9889.456079915673;9903.356281841658;9939.055789699967;6696.799096027127;6963.6866341013765;7236.095488063992;7383.335499805044;7418.035655364768;13484.32578371058;14479.131252124906;14666.706665866835;14722.190279534729;14851;14272.429102835771;14741.705165896836;14908.25458727081;14914.925425372803;15160.772588411402;10293.330933489298;10411.271211015157;10518.579256829642;10580.735481613021;10591.417472039111;11321;11335.206535542433;11566.248193867372;11618.477168527606;11712.765744685228;9380.624775008922;9601.57834164528;9673.613055477983;9951.601935922483;9952.800943981225;9259.72220833376;9483.52582370865;9594.904050959402;9595.28035397362;9621.56702948355;8015.198480151938;8199.0980992092;8225.506469611842;8425.662973480992;8626.18051285127;5951.226340575698;6107.694615269308;6185.907211391923;6253.312135664983;6378.043293505825;6502.577332473374;6591.96704016496;6796.388325050769;6854.931450685429;6984.266652001466 02:36:05 INFO - PID 3530 | |4;prototype.html;437.41604957381895;448.6097095526892;456.97029693069953;468.79607370793684;471.96932199407047;6229;6233.252009758824;6271.341509141532;6292.716827742751;6374.713137908793;5923.703814809253;6145.293291271505;6161.81514554563;6174.9382506174925;6182.56722029457;4886.193778026622;4897.363342765444;4939.3578834751615;4949.876253093666;4950.579200767921;4905.533974272438;4910.828121015765;4960.454350021495;4978.551930326288;4989.301497790312;4824.348712923763;4859.173940430118;4866.099771542276;4883.116883116883;4889.559939605435;4661.673682842203;4834.95165048352;4850.5149485051215;4861.440934292566;4869.342638743759;4325;4344.87169238148;4348.195583816972;4358.302671572533;4378.912421751579;6071.757129714806;6073.362296958844;6073.544484163705;6087.0869369594475;6099.115628233925;5564.137558678412;5578.30271216098;5578.88002559025;5588.6646801192055;5592.273004509429;6448.742050317982;6516.380943810331;6531.7387304507765;6535;6535.15043044406;4716.481187069419;4720.740359280238;4728.810847566093;4729.290606409032;4741.668083234175;6806.829829254259;6830.692618832164;6873.415759660435;6896.931030689679;6910.861782764367;4845.248986407112;4855.5387238212315;4857.562819346276;4862.902741945141;4867.148249056472;4882.36529251195;4917.360743103373;4925.448483727614;4932.753362331869;4946.109700253917;5574.4914788344595;5587.27365442498;5587.3015873015875;5599.60802743804;5608.130739735348;6597.73609055642;6602.372774586406;6609.570377925419;6636.170478690164;6647.933520664828;1587.317453494985;1684.5704345392091;1686.991565042167;1687.485316978309;1693.4242357598475;1167.3171194850938;1185.1644590563633;1189.8334233207186;1192.8031874740743;1196.8623608285159;5583.190437386637;5764.855878603068;5784.8264552062665;5802.622829516068;5827.533797296206;6621;6661.16735408074;6668.533202675766;6683.598984060972;6798.422134118655;5789.797357092481;5799.855003624859;5807.0998995155815;5810.954028274867;5816.127580862904;3583.7670551414076;3589.8205089745406;3599.6220396857952;3609.3322735294055;3610.4403817408343;6519.119918810995;6520.315366886503;6526.314736952647;6526.445252153525;6537.1501704778075;6623.271440141581;6939.479539034593;6942.757003504853;6955.965220173866;6969.0940177776565;6425.228972523327;6516.168029613564;6524.412802847766;6532.314107018695;6535.411812936859;6750.1562304711915;6776.93223067763;6783.626900520519;6789.1852977643;6823.863522729617;6639.6680165992475;6719.798406047827;6727;6741;6747.190337159573;6479.546431749733;6543.280239173782;6557.2131344239;6572.7042283098335;6579.2104947406615;4753.83361582343;4792.496787837227;4824.710517368969;4825.10735513931;4835.274708793709;6752.864942701217;6756.189257289157;6760.898586521304;6811.148606424197;6816.216135144522;6513.576617519846;6522.934770652233;6579.519608088333;6589.769358072444;6592.274849766426;6553.868922621617;6591.967040164768;6621.27166011748;6630.734770609121;6646.767363142267;6330.461910737455;6512.446442052289;6528.118703974903;6574.4411725002;6584.736610535525;6597.571157874723;6630.005499175162;6675.232348279816;6675.265720770809;6702.497312701469;6376.74493020274;6401;6403.167588213689;6416.887809412525;6451.1936007999 02:36:05 INFO - PID 3530 | |5;yui.html;813.8351983723297;833.5748768128253;833.7790485521338;847.2925107535208;848.4654667559437;12187.207831490969;16664.58338541537;16903.323867045317;17007.82992170078;17041.82958170418;13666.726665466686;13785.655358616039;13956.162630242192;13963;13999.160050396984;711.1395211793736;972.3825370889465;973.6981535723913;975.8194733974202;978.3885071830106;982.2731178927578;987.5950860147341;987.6839411388358;992.1219720547296;995.9502024898762;1038.942858142802;1040.9895901041007;1045.0229035851503;1045.9110975567048;1045.9320144190642;953.3850666320254;977.9608815647366;1038.729930218145;1039.7816458543714;1040.011988610819;753.1263734068455;756.8032311598969;756.9016027916391;757.01209921053;758.1395116542764;16734.995900246024;16810.159492025472;16837.494875153767;16849.578760530963;16918.238679259463;17458.738118928228;18849.151788169565;19017.80982190174;19053.80946190534;19088.90455547727;14006.369713362923;14452.638684032878;14478.92760536201;14560.708785824225;14580.562583122417;3440.673136052071;3475.9652403475893;3478.843452044639;3487.9128021799406;3494.1264683829045;76937.61531192309;79151.604241979;79910.6004469974;80472;81013.59493202555;14460.349284282232;14460.710785784226;14741;14749.262536873113;15159.09045457254;25490;25841.353966150997;25945.481090378464;25963.610545841828;26028.86985565098;7924.722634707758;8161.673533058611;8171.223733745284;8171.468854524437;8241.711540096068;3922.7057970652313;3975.2447035063246;4019.336809426412;4025.1144748155943;4030.7783071931326;4183.247015537232;4316.848910288188;4320.65434765218;4326.762028088422;4664.906701865943;981.7889153831818;984.3601658921615;996.1084829077935;996.277698668474;997.3965750720854;672.831792051987;683.1835956032494;689.0319101662172;714.2250658036089;718.2207305073949;11413.372264525531;11819.586314478953;12023.819642705366;12270.263784172977;12795.232286062866;659.6306068601599;685.348918527391;685.5030103175158;696.7352406085655;703.7536862098327;5207.765650545734;5373.193921094019;5440.156775699773;5503.11950087984;5559.6664200148125;89114.21957541227;89815;90287;90835.54582227046;92363;56270.71864640651;75702;77410.22589774143;79743.20256797358;79807;58738;65794.34205657979;66258;68174;69612;11108.722281943015;12349.19730217533;12388;12436.56472023511;12641.810372844231;28709.712902870702;30554;30659;30916;31515.21211969719;36908.81545592255;37846;39160;39732;40068.1986360277;15698.136602486516;15762.448314308944;15849.841501585297;16266.755998659793;16271.3491460345;16993.91503042477;17537.298508059535;17682.115894205497;17725.822741772416;17754.822451775835;15795.526134215992;16114.838851611334;16578.336866525206;17025.40411085606;17142;16004.19979001022;16030.599235018752;16143.273552690393;16261.51215463538;16428.096454695107;15935.203239838194;16174.353025878832;16301.59246018859;16447.342106315613;16583.751243731596;8928.910710893068;9504.809903802023;9916.851247231441;9933.801323973625;9938.403695778277;11254.60608878718;11318.434078296217;11608.477618507357;11646.592369267035;11681.299122052704 02:36:05 INFO - PID 3530 | __end_tp_report 02:36:05 INFO - PID 3530 | __start_cc_report 02:36:05 INFO - PID 3530 | _x_x_mozilla_cycle_collect,386 02:36:05 INFO - PID 3530 | __end_cc_report 02:36:05 INFO - PID 3530 | __startTimestamp1497173765234__endTimestamp 02:36:05 INFO - PID 3530 | 02:36:05 INFO - PID 3530 | ------- Summary: start ------- 02:36:05 INFO - PID 3530 | Number of tests: 6 02:36:05 INFO - PID 3530 | 02:36:05 INFO - PID 3530 | [#0] dojo.html Cycles:165 Average:5912.14 Median:6130.42 stddev:680.66 (11.1%) stddev-sans-first:643.99 02:36:05 INFO - PID 3530 | Values: 3025.9 3029.2 3058.8 3081.8 3101.8 5859.3 5902.3 5907.9 5909.8 5934.3 5880.7 5918.9 5953.6 5962.7 5976.6 5382.2 5431.8 5452.3 5454.4 5563.2 5538.4 5591.5 5606.6 5614.5 5656.1 5580.3 5589.0 5601.0 5623.3 5631.2 5516.4 5589.4 5617.7 5637.8 5640.1 5246.3 5356.2 5442.2 5480.3 5523.3 5788.2 5846.7 5884.8 5909.8 5941.8 6352.5 6394.6 6408.7 6408.9 6422.7 6453.7 6455.7 6459.4 6467.5 6470.6 5919.8 5926.2 5973.0 5977.4 5980.2 6428.5 6526.6 6540.0 6592.2 6625.6 6116.5 6144.7 6155.9 6198.0 6206.5 6349.0 6349.7 6373.9 6374.6 6400.2 6167.6 6282.6 6303.5 6390.9 6404.3 6287.2 6316.1 6343.9 6397.1 6413.6 5197.5 5240.9 5244.5 5252.6 5266.0 4460.6 4460.8 4472.1 4475.8 4492.0 5517.5 5572.9 5575.4 5617.0 5617.1 6398.3 6398.5 6428.1 6441.9 6493.8 5588.9 5614.6 5649.4 5666.8 5675.2 5661.0 5726.3 5735.8 5749.9 5768.9 6247.9 6288.7 6294.7 6304.2 6304.4 6482.2 6495.5 6506.1 6509.3 6548.2 6038.7 6126.1 6129.1 6130.4 6281.6 6159.2 6248.3 6272.3 6279.1 6294.7 6477.6 6513.0 6522.9 6523.7 6557.1 6325.3 6333.7 6338.7 6351.8 6365.0 6112.9 6317.5 6330.9 6339.3 6364.5 6111.9 6123.2 6145.8 6178.6 6262.8 6251.8 6317.0 6334.2 6355.0 6361.1 6150.3 6173.2 6186.3 6187.2 6189.6 02:36:05 INFO - PID 3530 | 02:36:05 INFO - PID 3530 | [#1] ext.html Cycles:180 Average:34119.78 Median:18406.87 stddev:48767.60 (264.9%) stddev-sans-first:48839.80 02:36:05 INFO - PID 3530 | Values: 687.9 720.1 734.5 755.8 758.9 37163.3 37680.6 37801.2 37908.6 38020.0 33753.8 34241.3 34312.0 34498.3 34554.3 6190.8 6307.2 6311.0 6344.5 6350.4 6319.6 6370.5 6384.9 6404.8 6435.8 6331.7 6385.4 6386.4 6416.0 6423.3 6314.5 6384.6 6385.1 6390.2 6391.1 5725.2 5747.9 5757.5 6874.9 7091.3 34937.0 34992.8 35236.6 35344.5 35381.3 3418.6 3451.6 3461.0 3470.3 3478.3 27135.6 27221.0 27308.0 27343.6 27496.3 3351.9 3360.9 3383.1 3393.3 3425.4 144950.0 147813.3 167524.0 168969.0 169086.0 36096.0 41602.0 42246.6 42279.4 42520.0 45364.0 45463.3 45479.0 45492.8 45810.1 15020.5 15119.1 15184.5 15192.3 15220.7 12053.9 12168.8 12187.3 12199.8 12221.6 13634.9 13649.0 13680.9 13749.7 13827.5 5390.3 5407.3 5493.6 5644.7 5684.3 975.2 984.3 990.4 1016.3 1023.2 21524.0 21736.6 21869.3 21958.0 22469.9 1065.1 1066.7 1077.2 1093.8 1119.1 11506.4 11559.2 11647.8 11934.8 12244.3 209002.0 211257.0 212294.0 212906.0 213889.0 46529.3 46872.0 46907.0 47011.0 51557.7 1465.4 1472.4 1481.0 1485.5 1494.2 25575.6 27700.3 27765.6 27766.9 27929.4 35235.3 35547.3 35644.6 35649.0 35680.6 188380.0 188756.0 189454.0 190015.0 190226.0 27840.0 27985.7 28375.3 30397.5 33435.0 38126.8 38524.8 38615.2 38769.8 40421.6 28110.0 29034.4 29333.7 29416.3 30740.5 29078.0 29582.6 29921.4 30313.5 30686.8 32416.0 32443.8 32525.8 33461.8 33862.5 27522.4 28969.9 29147.7 29634.3 29720.0 22061.4 23241.3 23263.8 23284.8 23451.6 02:36:05 INFO - PID 3530 | 02:36:05 INFO - PID 3530 | [#2] jquery.html Cycles:180 Average:29810.70 Median:12125.42 stddev:70561.45 (581.9%) stddev-sans-first:70725.02 02:36:05 INFO - PID 3530 | Values: 476.9 483.3 487.0 506.2 512.0 19241.6 19898.5 19929.8 20082.4 20189.7 22016.6 24272.3 24288.0 24636.1 24656.9 5936.2 6036.6 6071.3 6075.8 6083.2 6038.6 6056.1 6072.8 6078.9 6090.6 5812.4 5985.4 6055.1 6059.7 6091.9 5968.9 5975.4 6042.4 6053.1 6080.3 5571.8 5580.4 5591.1 5594.3 5603.7 26171.6 26303.6 26422.2 26486.3 26542.6 1813.7 1892.3 1903.2 1938.0 1939.3 16760.9 17006.9 17078.2 17125.2 17194.2 2250.8 2296.7 2323.6 2331.7 2347.8 97870.5 103565.0 104130.0 115662.0 116075.4 12981.2 13031.5 13054.5 13184.7 13521.1 19552.3 19558.2 19586.8 19593.7 19679.0 9272.4 9522.2 9574.6 9599.2 9655.1 8874.8 8902.3 8947.0 8995.0 9019.5 8260.3 8272.2 8329.3 8334.5 8355.5 2200.0 2234.3 2247.8 2257.7 2349.8 932.5 943.6 954.8 986.4 991.6 18438.9 18465.6 19158.6 19269.6 19322.9 963.7 976.1 996.5 998.2 999.9 10231.8 10285.4 10320.6 10458.5 10614.0 415755.0 417739.0 421432.0 422788.0 423412.0 100942.5 104530.0 105471.5 105888.5 106635.5 1065.3 1103.9 1109.0 1151.5 1203.4 18187.4 19789.9 20264.7 20590.9 20614.8 44621.6 47084.3 47539.8 47739.3 49328.8 60072.7 60161.4 60179.7 60683.7 60766.4 11073.2 11146.8 11193.0 11210.5 11230.4 16260.3 16634.8 16852.7 16999.8 18215.4 13626.3 13650.9 13705.1 13989.9 15318.8 13246.6 13272.3 13335.7 13343.5 13883.8 15298.3 15473.9 15529.1 15583.5 15608.6 11449.7 11516.3 11546.3 11547.3 11562.9 13768.9 14870.3 15008.2 15050.0 15099.8 02:36:05 INFO - PID 3530 | 02:36:05 INFO - PID 3530 | [#3] mootools.html Cycles:180 Average:7582.22 Median:2529.82 stddev:4912.09 (194.2%) stddev-sans-first:4902.99 02:36:05 INFO - PID 3530 | Values: 1272.8 1328.9 1331.3 1344.1 1359.7 11804.4 12203.6 12333.6 12392.1 12404.3 11856.8 12190.0 12213.3 12233.9 12270.2 2490.5 2540.4 2543.2 2544.0 2546.7 2450.8 2516.4 2517.2 2518.9 2519.3 2460.6 2477.2 2487.1 2502.5 2506.3 2382.1 2405.8 2411.4 2411.6 2412.7 2356.5 2368.6 2373.3 2384.4 2385.3 11718.7 11931.0 11987.8 11991.8 11994.5 6785.8 7055.9 7083.5 7084.6 7103.0 3942.3 4086.8 4132.7 4200.1 4231.8 1437.3 1486.7 1519.6 1531.9 1535.9 16948.2 17612.1 18571.4 18738.5 18750.3 5402.6 5919.4 6078.4 6103.1 6124.3 13520.8 13586.6 13596.8 13599.7 13642.6 7002.9 7052.4 7060.8 7065.4 7074.2 6440.2 6555.5 6585.7 6587.8 6598.0 4552.5 4658.2 4686.7 4707.0 4722.6 1350.4 1364.6 1370.8 1392.5 1401.6 858.1 860.7 867.6 872.6 891.6 6614.8 6643.0 6706.6 6754.3 6815.4 666.7 679.6 702.7 704.4 713.2 4044.9 4111.5 4294.2 4404.0 4702.9 15417.4 15678.0 16012.0 16063.8 16068.0 15540.0 15744.6 16022.6 16359.5 16371.6 9678.5 9824.7 9889.5 9903.4 9939.1 6696.8 6963.7 7236.1 7383.3 7418.0 13484.3 14479.1 14666.7 14722.2 14851.0 14272.4 14741.7 14908.3 14914.9 15160.8 10293.3 10411.3 10518.6 10580.7 10591.4 11321.0 11335.2 11566.2 11618.5 11712.8 9380.6 9601.6 9673.6 9951.6 9952.8 9259.7 9483.5 9594.9 9595.3 9621.6 8015.2 8199.1 8225.5 8425.7 8626.2 5951.2 6107.7 6185.9 6253.3 6378.0 6502.6 6592.0 6796.4 6854.9 6984.3 02:36:05 INFO - PID 3530 | 02:36:05 INFO - PID 3530 | [#4] prototype.html Cycles:180 Average:5486.16 Median:6122.20 stddev:1580.99 (25.8%) stddev-sans-first:1539.34 02:36:05 INFO - PID 3530 | Values: 437.4 448.6 457.0 468.8 472.0 6229.0 6233.3 6271.3 6292.7 6374.7 5923.7 6145.3 6161.8 6174.9 6182.6 4886.2 4897.4 4939.4 4949.9 4950.6 4905.5 4910.8 4960.5 4978.6 4989.3 4824.3 4859.2 4866.1 4883.1 4889.6 4661.7 4835.0 4850.5 4861.4 4869.3 4325.0 4344.9 4348.2 4358.3 4378.9 6071.8 6073.4 6073.5 6087.1 6099.1 5564.1 5578.3 5578.9 5588.7 5592.3 6448.7 6516.4 6531.7 6535.0 6535.2 4716.5 4720.7 4728.8 4729.3 4741.7 6806.8 6830.7 6873.4 6896.9 6910.9 4845.2 4855.5 4857.6 4862.9 4867.1 4882.4 4917.4 4925.4 4932.8 4946.1 5574.5 5587.3 5587.3 5599.6 5608.1 6597.7 6602.4 6609.6 6636.2 6647.9 1587.3 1684.6 1687.0 1687.5 1693.4 1167.3 1185.2 1189.8 1192.8 1196.9 5583.2 5764.9 5784.8 5802.6 5827.5 6621.0 6661.2 6668.5 6683.6 6798.4 5789.8 5799.9 5807.1 5811.0 5816.1 3583.8 3589.8 3599.6 3609.3 3610.4 6519.1 6520.3 6526.3 6526.4 6537.2 6623.3 6939.5 6942.8 6956.0 6969.1 6425.2 6516.2 6524.4 6532.3 6535.4 6750.2 6776.9 6783.6 6789.2 6823.9 6639.7 6719.8 6727.0 6741.0 6747.2 6479.5 6543.3 6557.2 6572.7 6579.2 4753.8 4792.5 4824.7 4825.1 4835.3 6752.9 6756.2 6760.9 6811.1 6816.2 6513.6 6522.9 6579.5 6589.8 6592.3 6553.9 6592.0 6621.3 6630.7 6646.8 6330.5 6512.4 6528.1 6574.4 6584.7 6597.6 6630.0 6675.2 6675.3 6702.5 6376.7 6401.0 6403.2 6416.9 6451.2 02:36:05 INFO - PID 3530 | 02:36:05 INFO - PID 3530 | [#5] yui.html Cycles:180 Average:18340.24 Median:3483.38 stddev:22976.10 (659.6%) stddev-sans-first:23002.86 02:36:05 INFO - PID 3530 | Values: 813.8 833.6 833.8 847.3 848.5 12187.2 16664.6 16903.3 17007.8 17041.8 13666.7 13785.7 13956.2 13963.0 13999.2 711.1 972.4 973.7 975.8 978.4 982.3 987.6 987.7 992.1 996.0 1038.9 1041.0 1045.0 1045.9 1045.9 953.4 978.0 1038.7 1039.8 1040.0 753.1 756.8 756.9 757.0 758.1 16735.0 16810.2 16837.5 16849.6 16918.2 17458.7 18849.2 19017.8 19053.8 19088.9 14006.4 14452.6 14478.9 14560.7 14580.6 3440.7 3476.0 3478.8 3487.9 3494.1 76937.6 79151.6 79910.6 80472.0 81013.6 14460.3 14460.7 14741.0 14749.3 15159.1 25490.0 25841.4 25945.5 25963.6 26028.9 7924.7 8161.7 8171.2 8171.5 8241.7 3922.7 3975.2 4019.3 4025.1 4030.8 4183.2 4316.8 4320.7 4326.8 4664.9 981.8 984.4 996.1 996.3 997.4 672.8 683.2 689.0 714.2 718.2 11413.4 11819.6 12023.8 12270.3 12795.2 659.6 685.3 685.5 696.7 703.8 5207.8 5373.2 5440.2 5503.1 5559.7 89114.2 89815.0 90287.0 90835.5 92363.0 56270.7 75702.0 77410.2 79743.2 79807.0 58738.0 65794.3 66258.0 68174.0 69612.0 11108.7 12349.2 12388.0 12436.6 12641.8 28709.7 30554.0 30659.0 30916.0 31515.2 36908.8 37846.0 39160.0 39732.0 40068.2 15698.1 15762.4 15849.8 16266.8 16271.3 16993.9 17537.3 17682.1 17725.8 17754.8 15795.5 16114.8 16578.3 17025.4 17142.0 16004.2 16030.6 16143.3 16261.5 16428.1 15935.2 16174.4 16301.6 16447.3 16583.8 8928.9 9504.8 9916.9 9933.8 9938.4 11254.6 11318.4 11608.5 11646.6 11681.3 02:36:05 INFO - PID 3530 | -------- Summary: end -------- 02:36:05 INFO - PID 3530 | 02:36:06 INFO - TEST-INFO | 3530: exit 0 02:36:06 INFO - TEST-OK | dromaeo_css | took 1144910ms 02:36:06 INFO - TEST-START | kraken 02:36:06 INFO - operating with platform_type : linux_ 02:36:06 INFO - Initialising browser for kraken test... 02:36:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47603/getInfo.html -profile /tmp/tmp8qxfoR/profile 02:36:06 INFO - TEST-INFO | started process 3934 (/builds/slave/test/build/application/firefox/firefox http://localhost:47603/getInfo.html) 02:36:40 INFO - TEST-INFO | 3934: killed by SIGTERM 02:36:41 INFO - Browser initialized. 02:36:41 INFO - Running cycle 1/1 for kraken test... 02:36:41 INFO - TEST-INFO | started process 4142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8qxfoR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:36:52 INFO - PID 4142 | RSS: Main: 184492032 02:36:52 INFO - PID 4142 | 02:36:55 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47603/tests/kraken/driver.html?testName=audio-beat-detection) 02:36:56 INFO - PID 4142 | RSS: Main: 187494400 02:36:56 INFO - PID 4142 | 02:36:58 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47603/tests/kraken/driver.html?testName=audio-dft) 02:36:59 INFO - PID 4142 | RSS: Main: 188112896 02:36:59 INFO - PID 4142 | 02:37:02 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47603/tests/kraken/driver.html?testName=audio-fft) 02:37:03 INFO - PID 4142 | RSS: Main: 184049664 02:37:03 INFO - PID 4142 | 02:37:05 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47603/tests/kraken/driver.html?testName=audio-oscillator) 02:37:05 INFO - PID 4142 | RSS: Main: 185032704 02:37:05 INFO - PID 4142 | 02:37:07 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47603/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:37:08 INFO - PID 4142 | RSS: Main: 184922112 02:37:08 INFO - PID 4142 | 02:37:11 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47603/tests/kraken/driver.html?testName=imaging-darkroom) 02:37:12 INFO - PID 4142 | RSS: Main: 185630720 02:37:12 INFO - PID 4142 | 02:37:15 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47603/tests/kraken/driver.html?testName=imaging-desaturate) 02:37:16 INFO - PID 4142 | RSS: Main: 187879424 02:37:16 INFO - PID 4142 | 02:37:19 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47603/tests/kraken/driver.html?testName=json-parse-financial) 02:37:19 INFO - PID 4142 | RSS: Main: 186888192 02:37:19 INFO - PID 4142 | 02:37:21 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47603/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:37:22 INFO - PID 4142 | RSS: Main: 186335232 02:37:22 INFO - PID 4142 | 02:37:23 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47603/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:37:24 INFO - PID 4142 | RSS: Main: 186257408 02:37:24 INFO - PID 4142 | 02:37:26 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47603/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:37:27 INFO - PID 4142 | RSS: Main: 186699776 02:37:27 INFO - PID 4142 | 02:37:29 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:37:30 INFO - PID 4142 | RSS: Main: 185933824 02:37:30 INFO - PID 4142 | 02:37:33 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:37:34 INFO - PID 4142 | RSS: Main: 186253312 02:37:34 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:47603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47603/tests/kraken/driver.html?testName=ai-astar) 02:37:36 INFO - PID 4142 | RSS: Main: 187424768 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | __start_tp_report 02:37:36 INFO - PID 4142 | _x_x_mozilla_page_load 02:37:36 INFO - PID 4142 | _x_x_mozilla_page_load_details 02:37:36 INFO - PID 4142 | |i|pagename|runs| 02:37:36 INFO - PID 4142 | |0;ai-astar;101;110;111;109;114;111;111;111;110;111 02:37:36 INFO - PID 4142 | |1;audio-beat-detection;144;120;148;176;124;152;148;123;175;124 02:37:36 INFO - PID 4142 | |2;audio-dft;164;163;163;162;165;167;169;171;179;165 02:37:36 INFO - PID 4142 | |3;audio-fft;75;74;74;165;75;75;76;75;99;74 02:37:36 INFO - PID 4142 | |4;audio-oscillator;84;84;142;83;86;82;132;84;84;135 02:37:36 INFO - PID 4142 | |5;imaging-gaussian-blur;114;115;115;115;114;114;115;117;117;115 02:37:36 INFO - PID 4142 | |6;imaging-darkroom;152;151;150;152;151;151;151;150;150;152 02:37:36 INFO - PID 4142 | |7;imaging-desaturate;94;95;96;95;94;96;94;96;95;95 02:37:36 INFO - PID 4142 | |8;json-parse-financial;54;56;55;54;55;54;54;54;54;56 02:37:36 INFO - PID 4142 | |9;json-stringify-tinderbox;57;56;56;57;56;56;58;58;59;56 02:37:36 INFO - PID 4142 | |10;stanford-crypto-aes;79;78;86;82;78;82;78;78;78;78 02:37:36 INFO - PID 4142 | |11;stanford-crypto-ccm;134;128;130;140;139;136;129;131;126;155 02:37:36 INFO - PID 4142 | |12;stanford-crypto-pbkdf2;187;191;193;193;193;191;194;197;190;184 02:37:36 INFO - PID 4142 | |13;stanford-crypto-sha256-iterative;74;74;75;75;74;74;71;72;75;72 02:37:36 INFO - PID 4142 | __end_tp_report 02:37:36 INFO - PID 4142 | __start_cc_report 02:37:36 INFO - PID 4142 | _x_x_mozilla_cycle_collect,1007 02:37:36 INFO - PID 4142 | __end_cc_report 02:37:36 INFO - PID 4142 | __startTimestamp1497173856363__endTimestamp 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | ------- Summary: start ------- 02:37:36 INFO - PID 4142 | Number of tests: 14 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.38 (3.0%) stddev-sans-first:1.36 02:37:36 INFO - PID 4142 | Values: 101.0 110.0 111.0 109.0 114.0 111.0 111.0 111.0 110.0 111.0 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:148.00 stddev:20.80 (14.1%) stddev-sans-first:22.06 02:37:36 INFO - PID 4142 | Values: 144.0 120.0 148.0 176.0 124.0 152.0 148.0 123.0 175.0 124.0 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#2] audio-dft Cycles:10 Average:166.80 Median:166.00 stddev:5.14 (3.1%) stddev-sans-first:5.35 02:37:36 INFO - PID 4142 | Values: 164.0 163.0 163.0 162.0 165.0 167.0 169.0 171.0 179.0 165.0 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#3] audio-fft Cycles:10 Average:86.20 Median:75.00 stddev:28.72 (38.3%) stddev-sans-first:30.18 02:37:36 INFO - PID 4142 | Values: 75.0 74.0 74.0 165.0 75.0 75.0 76.0 75.0 99.0 74.0 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#4] audio-oscillator Cycles:10 Average:99.60 Median:84.00 stddev:25.48 (30.3%) stddev-sans-first:26.40 02:37:36 INFO - PID 4142 | Values: 84.0 84.0 142.0 83.0 86.0 82.0 132.0 84.0 84.0 135.0 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.10 (1.0%) stddev-sans-first:1.09 02:37:36 INFO - PID 4142 | Values: 114.0 115.0 115.0 115.0 114.0 114.0 115.0 117.0 117.0 115.0 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 02:37:36 INFO - PID 4142 | Values: 152.0 151.0 150.0 152.0 151.0 151.0 151.0 150.0 150.0 152.0 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 02:37:36 INFO - PID 4142 | Values: 94.0 95.0 96.0 95.0 94.0 96.0 94.0 96.0 95.0 95.0 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:0.84 (1.5%) stddev-sans-first:0.87 02:37:36 INFO - PID 4142 | Values: 54.0 56.0 55.0 54.0 55.0 54.0 54.0 54.0 54.0 56.0 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:1.10 (1.9%) stddev-sans-first:1.17 02:37:36 INFO - PID 4142 | Values: 57.0 56.0 56.0 57.0 56.0 56.0 58.0 58.0 59.0 56.0 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:78.50 stddev:2.75 (3.5%) stddev-sans-first:2.91 02:37:36 INFO - PID 4142 | Values: 79.0 78.0 86.0 82.0 78.0 82.0 78.0 78.0 78.0 78.0 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:135.00 stddev:8.50 (6.3%) stddev-sans-first:9.01 02:37:36 INFO - PID 4142 | Values: 134.0 128.0 130.0 140.0 139.0 136.0 129.0 131.0 126.0 155.0 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.30 Median:193.00 stddev:3.68 (1.9%) stddev-sans-first:3.56 02:37:36 INFO - PID 4142 | Values: 187.0 191.0 193.0 193.0 193.0 191.0 194.0 197.0 190.0 184.0 02:37:36 INFO - PID 4142 | 02:37:36 INFO - PID 4142 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.00 stddev:1.43 (1.9%) stddev-sans-first:1.51 02:37:36 INFO - PID 4142 | Values: 74.0 74.0 75.0 75.0 74.0 74.0 71.0 72.0 75.0 72.0 02:37:36 INFO - PID 4142 | -------- Summary: end -------- 02:37:36 INFO - PID 4142 | 02:37:37 INFO - TEST-INFO | 4142: exit 0 02:37:37 INFO - TEST-OK | kraken | took 91388ms 02:37:37 INFO - SUITE-END | took 1236s 02:37:37 INFO - Completed test suite (00:20:36) 02:37:37 INFO - javascript benchmark 02:37:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7741.844947466529, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3025.939481210375, 3029.1972627253795, 3058.801177923436, 3081.8150910945346, 3101.782875198737, 5859.296884373881, 5902.321233058189, 5907.911381329283, 5909.822705318842, 5934.347221805598, 5880.705964701759, 5918.88162236755, 5953.553483488745, 5962.731677074531, 5976.641401515912, 5382.1926710993275, 5431.809886653968, 5452.318460192476, 5454.372747134091, 5563.221149039137, 5538.418466061046, 5591.496765291123, 5606.635568688042, 5614.466625670555, 5656.095024796034, 5580.302462192226, 5588.972055139719, 5600.971995140018, 5623.297087864017, 5631.211630371751, 5516.448355164492, 5589.413111623262, 5617.747201375927, 5637.830865074055, 5640.097584386478, 5246.291750613695, 5356.223347614613, 5442.183672449125, 5480.314960629921, 5523.28197334344, 5788.218590490272, 5846.7076646167525, 5884.794032208895, 5909.793157239519, 5941.762329506814, 6352.46004089653, 6394.552381333308, 6408.679566021727, 6408.903866442007, 6422.678866056678, 6453.709583068726, 6455.709493072823, 6459.418652321267, 6467.5472716909835, 6470.57941233823, 5919.822405327847, 5926.199963005025, 5973.0, 5977.372375900555, 5980.162777211194, 6428.485721142298, 6526.60840349571, 6540.0, 6592.208934927839, 6625.569337993015, 6116.5106791457465, 6144.692765361714, 6155.855290047947, 6197.96901015492, 6206.534509911684, 6348.968255158695, 6349.6507692077375, 6373.872522549523, 6374.617522948638, 6400.199975003125, 6167.599106058092, 6282.591631543935, 6303.46420554258, 6390.904136437957, 6404.295527491972, 6287.245530536365, 6316.052592111128, 6343.936560634427, 6397.136386587751, 6413.551051426449, 5197.532222099953, 5240.868978275574, 5244.475552444725, 5252.553532949666, 5265.973670131625, 4460.598546130864, 4460.843870464518, 4472.08322293929, 4475.820967161277, 4492.011757413364, 5517.503424691797, 5572.944270557324, 5575.4424557543925, 5617.01702202113, 5617.101263797773, 6398.29618741938, 6398.456131228804, 6428.132202152649, 6441.871162576816, 6493.772717954944, 5588.860278492989, 5614.578906582023, 5649.4350564944, 5666.801661941895, 5675.233843431167, 5661.0, 5726.312842458931, 5735.77056917727, 5749.942500574941, 5768.855778605568, 6247.937520624736, 6288.717007734755, 6294.716737746812, 6304.211973503312, 6304.401081897213, 6482.189726284215, 6495.545311828127, 6506.056621789909, 6509.283978762238, 6548.246951600437, 6038.6678732670125, 6126.120738204555, 6129.14485165794, 6130.417610327012, 6281.59169653971, 6159.19930409044, 6248.250209974832, 6272.310045894857, 6279.089532017923, 6294.685265736786, 6477.578957367756, 6512.967435162794, 6522.869542609216, 6523.706433210422, 6557.082008518906, 6325.272593651604, 6333.714982825876, 6338.746450141943, 6351.77768778109, 6365.0, 6112.868254062901, 6317.526185536011, 6330.905036424365, 6339.270983836734, 6364.490840732823, 6111.908321375272, 6123.231910558009, 6145.7708458307625, 6178.578926846761, 6262.812115636538, 6251.812445626639, 6316.968415157895, 6334.239891212899, 6355.046742988588, 6361.14124593174, 6150.292716337678, 6173.228346456693, 6186.319504854372, 6187.16473276102, 6189.566730329014], "value": 5862.066945310431, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.9243283238843, 720.094966202627, 734.5188901269669, 755.8110472381903, 758.9468737188399, 37163.25673486532, 37680.62319376806, 37801.24397512048, 37908.62091379085, 38019.99999999996, 33753.831230843876, 34241.31517369651, 34312.0, 34498.310033799375, 34554.30891382171, 6190.84522886927, 6307.243130824308, 6310.9586918158675, 6344.460720838734, 6350.42846143847, 6319.589226700273, 6370.49036077115, 6384.93615063848, 6404.839879003039, 6435.8391040223905, 6331.715072821711, 6385.361463853601, 6386.425221730044, 6416.0, 6423.293437721847, 6314.526410519229, 6384.58500197488, 6385.106085148037, 6390.169277993878, 6391.105245265643, 5725.1698503716725, 5747.913781293284, 5757.510611598019, 6874.8625027499675, 7091.326323999212, 34937.0, 34992.82503587466, 35236.64763352359, 35344.46983295253, 35381.29237415263, 3418.572678415198, 3451.551298331201, 3461.0309113448275, 3470.340635279289, 3478.286951175003, 27135.592966105523, 27221.0, 27308.0, 27343.589846152325, 27496.312592185157, 3351.899443016689, 3360.8991730247885, 3383.1034775784437, 3393.321335732863, 3425.3663072331697, 144950.0, 147813.26093369463, 167524.0, 168969.0, 169086.0, 36096.0, 41602.0, 42246.57753422488, 42279.365809512885, 42520.0, 45364.0, 45463.318050229274, 45479.0, 45492.772536137105, 45810.083798323845, 15020.549383518512, 15119.092854428549, 15184.46854360092, 15192.316345764468, 15220.695586088215, 12053.939730301292, 12168.756624867454, 12187.268763874195, 12199.817002744965, 12221.572244971383, 13634.86365136336, 13649.0, 13680.863191368158, 13749.656258593615, 13827.51603693866, 5390.326209223847, 5407.270018547446, 5493.587980901449, 5644.701718604744, 5684.317881854204, 975.1564896364594, 984.3109823123842, 990.3810118675827, 1016.3139880580578, 1023.2325755683238, 21524.0, 21736.580788928342, 21869.343919682437, 21958.01188946469, 22469.88765056197, 1065.0946695308926, 1066.7119877632995, 1077.1921059205595, 1093.830456279278, 1119.0935342372704, 11506.424678766196, 11559.248648837798, 11647.776983416788, 11934.820977685342, 12244.265344079384, 209002.0, 211257.0, 212294.0, 212906.0, 213889.0, 46529.30206046912, 46872.0, 46907.0, 47011.0, 51557.74221128871, 1465.4431316099815, 1472.3521650473758, 1480.9777853332423, 1485.472657206676, 1494.2230040378943, 25575.570320819494, 27700.307492312855, 27765.583516247676, 27766.86116569404, 27929.44141117207, 35235.29529409449, 35547.28905421929, 35644.643553564136, 35649.0, 35680.64319356877, 188380.0, 188756.0, 189454.0, 190015.0, 190226.0, 27840.025599103934, 27985.720142798313, 28375.29061773472, 30397.544036839023, 33435.0, 38126.80936595299, 38524.80737596294, 38615.22769544537, 38769.80615096907, 40421.59578404296, 28110.0, 29034.41931161407, 29333.70666293395, 29416.26459338534, 30740.538891916192, 29078.0, 29582.556261655664, 29921.401571968872, 30313.545296821005, 30686.846565767923, 32416.0, 32443.837780810944, 32525.83737081394, 33461.83269083639, 33862.492062619574, 27522.449551009267, 28969.85515072411, 29147.70852291535, 29634.25914352072, 29719.959801406847, 22061.448463788533, 23241.3027609172, 23263.836808159187, 23284.76715232826, 23451.648225276294], "value": 15537.211503828976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.9236922092466, 483.31610770759386, 486.99006053286445, 506.1774616248597, 511.9590432765379, 19241.615167696636, 19898.502537436572, 19929.800701992994, 20082.397528074143, 20189.697154542657, 22016.559668806614, 24272.27183184507, 24288.0, 24636.137735179273, 24656.876715616443, 5936.228290322263, 6036.577439579231, 6071.301800292978, 6075.7569697212275, 6083.209182806229, 6038.6074905131245, 6056.061310496858, 6072.848178795543, 6078.939210607904, 6090.573659843791, 5812.418758124175, 5985.371535988724, 6055.122007308938, 6059.697015149247, 6091.878162436748, 5968.910466343008, 5975.432333928292, 6042.425969532931, 6053.092036194562, 6080.30076541199, 5571.832845014656, 5580.386157522669, 5591.133374326986, 5594.328680558318, 5603.7478313475585, 26171.607425888626, 26303.605445918325, 26422.207333780018, 26486.337841553923, 26542.6018609721, 1813.718873574585, 1892.3187652445108, 1903.172120127749, 1938.0, 1939.3115444017453, 16760.916195419068, 17006.914965425218, 17078.231479583323, 17125.22936467862, 17194.226259818337, 2250.763669814662, 2296.6899468571696, 2323.6049871521714, 2331.7408599356327, 2347.835651504395, 97870.51064744702, 103565.0, 104130.0, 115662.0, 116075.41962290135, 12981.221126732426, 13031.478740850449, 13054.477820887249, 13184.670383240496, 13521.121127126902, 19552.31566895152, 19558.21767129299, 19586.804131958783, 19593.706094408597, 19679.0, 9272.443653380818, 9522.190613797766, 9574.617015319449, 9599.16033586571, 9655.131038206595, 8874.778130546789, 8902.287816974627, 8946.955265223633, 8995.0, 9019.549022548847, 8260.297874680598, 8272.214139656722, 8329.333653307842, 8334.458260213189, 8355.540445275568, 2199.973061554341, 2234.273860995183, 2247.775222477772, 2257.7064981552294, 2349.8355115141776, 932.5337331334333, 943.613118621362, 954.8424509955779, 986.3835103060587, 991.5686676295691, 18438.907805460887, 18465.630687386176, 19158.61682766365, 19269.61460770777, 19322.903385482983, 963.7397902566267, 976.097110173087, 996.4868092932146, 998.2413365842012, 999.8850132234886, 10231.795364092677, 10285.43430111351, 10320.62152462832, 10458.52936617854, 10614.044735973644, 415755.0, 417739.0, 421432.0, 422788.0, 423412.0, 100942.49528752457, 104530.0, 105471.47264263783, 105888.47055764672, 106635.46682266539, 1065.2596445470324, 1103.933763974164, 1108.9500972456258, 1151.5393842462913, 1203.3862730007759, 18187.363442279988, 19789.901050494656, 20264.696029559862, 20590.897045514677, 20614.793852061288, 44621.55378446174, 47084.29373559331, 47539.76230118966, 47739.28391074067, 49328.75335623299, 60072.69963650154, 60161.39838601733, 60179.699101504215, 60683.69658151681, 60766.39233607784, 11073.224874259047, 11146.777064458827, 11193.048590869867, 11210.49552770111, 11230.382328971986, 16260.268287926836, 16634.753470560056, 16852.662946741242, 16999.830001699826, 18215.362462313755, 13626.250556219107, 13650.863491365357, 13705.109167904055, 13989.887065675193, 15318.770218446509, 13246.602601921957, 13272.27002514871, 13335.733285334045, 13343.466261349437, 13883.791743124064, 15298.311575978885, 15473.922630386776, 15529.068255904682, 15583.532494025198, 15608.609784755017, 11449.656510304705, 11516.309021458404, 11546.307221566733, 11547.307161569997, 11562.88437115618, 13768.862311376757, 14870.256487175815, 15008.174550399834, 15050.0, 15099.773503397677], "value": 10577.768285642906, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.7836267834468, 1328.9335533223343, 1331.3343328335832, 1344.052443027665, 1359.653288411455, 11804.350760708168, 12203.633890983263, 12333.568325108623, 12392.132550721442, 12404.255744655316, 11856.762864742721, 12190.024798016137, 12213.328266945315, 12233.877661223385, 12270.202436841599, 2490.4645501217187, 2540.3522101864, 2543.186180422266, 2543.9618405723836, 2546.719860815309, 2450.779429851313, 2516.358328626207, 2517.2322441655288, 2518.874056297187, 2519.282004628681, 2460.6063029915126, 2477.2072936660275, 2487.092211342865, 2502.4869901670204, 2506.2606531073284, 2382.130522359335, 2405.8436201646923, 2411.3730430088126, 2411.565918134735, 2412.674288970984, 2356.4580146566213, 2368.5973384524673, 2373.2761507740133, 2384.4396566806786, 2385.33210701004, 11718.70703232426, 11931.0, 11987.760244795056, 11991.820122698167, 11994.460249288803, 6785.830354241183, 7055.858882822315, 7083.539569927938, 7084.574925504487, 7103.0, 3942.2706799242233, 4086.7547947123267, 4132.669386449077, 4200.075983283673, 4231.788410579489, 1437.2669938331526, 1486.7323881701288, 1519.6276912156482, 1531.8544738249848, 1535.9462418815287, 16948.23732932021, 17612.119394030375, 18571.350002749976, 18738.531536711555, 18750.34373796924, 5402.648827826179, 5919.4080591940465, 6078.361772013964, 6103.05402662588, 6124.326324104345, 13520.797188042186, 13586.592402227949, 13596.796048059286, 13599.660008499668, 13642.590722278348, 7002.894956575656, 7052.365287124184, 7060.752873649398, 7065.43476521877, 7074.186468556079, 6440.194975628046, 6555.541112122106, 6585.73657053722, 6587.80236592903, 6598.0, 4552.499225085238, 4658.208104622222, 4686.671932964659, 4706.976465117653, 4722.598579120745, 1350.4260689207047, 1364.5769811358512, 1370.766969615168, 1392.463901397969, 1401.5585090696397, 858.1161403754144, 860.6772460327377, 867.6399294292797, 872.5768002518773, 891.572045418203, 6614.8346291343105, 6642.96678516614, 6706.631135287606, 6754.257031726506, 6815.352541508549, 666.6866572710818, 679.5786612300307, 702.7083760239443, 704.4329314901554, 713.1869668577825, 4044.8786536403954, 4111.527174374925, 4294.162638285567, 4403.9779801100785, 4702.858914232578, 15417.383304667912, 15678.0, 16011.95922265049, 16063.759043614355, 16068.0, 15540.0, 15744.606384840241, 16022.599435013984, 16359.509214723577, 16371.59071023234, 9678.467684277432, 9824.67366905473, 9889.456079915673, 9903.356281841658, 9939.055789699967, 6696.799096027127, 6963.6866341013765, 7236.095488063992, 7383.335499805044, 7418.035655364768, 13484.32578371058, 14479.131252124906, 14666.706665866835, 14722.190279534729, 14851.0, 14272.429102835771, 14741.705165896836, 14908.25458727081, 14914.925425372803, 15160.772588411402, 10293.330933489298, 10411.271211015157, 10518.579256829642, 10580.735481613021, 10591.417472039111, 11321.0, 11335.206535542433, 11566.248193867372, 11618.477168527606, 11712.765744685228, 9380.624775008922, 9601.57834164528, 9673.613055477983, 9951.601935922483, 9952.800943981225, 9259.72220833376, 9483.52582370865, 9594.904050959402, 9595.28035397362, 9621.56702948355, 8015.198480151938, 8199.0980992092, 8225.506469611842, 8425.662973480992, 8626.18051285127, 5951.226340575698, 6107.694615269308, 6185.907211391923, 6253.312135664983, 6378.043293505825, 6502.577332473374, 6591.96704016496, 6796.388325050769, 6854.931450685429, 6984.266652001466], "value": 5627.106912398073, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.41604957381895, 448.6097095526892, 456.97029693069953, 468.79607370793684, 471.96932199407047, 6229.0, 6233.252009758824, 6271.341509141532, 6292.716827742751, 6374.713137908793, 5923.703814809253, 6145.293291271505, 6161.81514554563, 6174.9382506174925, 6182.56722029457, 4886.193778026622, 4897.363342765444, 4939.3578834751615, 4949.876253093666, 4950.579200767921, 4905.533974272438, 4910.828121015765, 4960.454350021495, 4978.551930326288, 4989.301497790312, 4824.348712923763, 4859.173940430118, 4866.099771542276, 4883.116883116883, 4889.559939605435, 4661.673682842203, 4834.95165048352, 4850.5149485051215, 4861.440934292566, 4869.342638743759, 4325.0, 4344.87169238148, 4348.195583816972, 4358.302671572533, 4378.912421751579, 6071.757129714806, 6073.362296958844, 6073.544484163705, 6087.0869369594475, 6099.115628233925, 5564.137558678412, 5578.30271216098, 5578.88002559025, 5588.6646801192055, 5592.273004509429, 6448.742050317982, 6516.380943810331, 6531.7387304507765, 6535.0, 6535.15043044406, 4716.481187069419, 4720.740359280238, 4728.810847566093, 4729.290606409032, 4741.668083234175, 6806.829829254259, 6830.692618832164, 6873.415759660435, 6896.931030689679, 6910.861782764367, 4845.248986407112, 4855.5387238212315, 4857.562819346276, 4862.902741945141, 4867.148249056472, 4882.36529251195, 4917.360743103373, 4925.448483727614, 4932.753362331869, 4946.109700253917, 5574.4914788344595, 5587.27365442498, 5587.3015873015875, 5599.60802743804, 5608.130739735348, 6597.73609055642, 6602.372774586406, 6609.570377925419, 6636.170478690164, 6647.933520664828, 1587.317453494985, 1684.5704345392091, 1686.991565042167, 1687.485316978309, 1693.4242357598475, 1167.3171194850938, 1185.1644590563633, 1189.8334233207186, 1192.8031874740743, 1196.8623608285159, 5583.190437386637, 5764.855878603068, 5784.8264552062665, 5802.622829516068, 5827.533797296206, 6621.0, 6661.16735408074, 6668.533202675766, 6683.598984060972, 6798.422134118655, 5789.797357092481, 5799.855003624859, 5807.0998995155815, 5810.954028274867, 5816.127580862904, 3583.7670551414076, 3589.8205089745406, 3599.6220396857952, 3609.3322735294055, 3610.4403817408343, 6519.119918810995, 6520.315366886503, 6526.314736952647, 6526.445252153525, 6537.1501704778075, 6623.271440141581, 6939.479539034593, 6942.757003504853, 6955.965220173866, 6969.0940177776565, 6425.228972523327, 6516.168029613564, 6524.412802847766, 6532.314107018695, 6535.411812936859, 6750.1562304711915, 6776.93223067763, 6783.626900520519, 6789.1852977643, 6823.863522729617, 6639.6680165992475, 6719.798406047827, 6727.0, 6741.0, 6747.190337159573, 6479.546431749733, 6543.280239173782, 6557.2131344239, 6572.7042283098335, 6579.2104947406615, 4753.83361582343, 4792.496787837227, 4824.710517368969, 4825.10735513931, 4835.274708793709, 6752.864942701217, 6756.189257289157, 6760.898586521304, 6811.148606424197, 6816.216135144522, 6513.576617519846, 6522.934770652233, 6579.519608088333, 6589.769358072444, 6592.274849766426, 6553.868922621617, 6591.967040164768, 6621.27166011748, 6630.734770609121, 6646.767363142267, 6330.461910737455, 6512.446442052289, 6528.118703974903, 6574.4411725002, 6584.736610535525, 6597.571157874723, 6630.005499175162, 6675.232348279816, 6675.265720770809, 6702.497312701469, 6376.74493020274, 6401.0, 6403.167588213689, 6416.887809412525, 6451.1936007999], "value": 5004.8568631860635, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.8351983723297, 833.5748768128253, 833.7790485521338, 847.2925107535208, 848.4654667559437, 12187.207831490969, 16664.58338541537, 16903.323867045317, 17007.82992170078, 17041.82958170418, 13666.726665466686, 13785.655358616039, 13956.162630242192, 13963.0, 13999.160050396984, 711.1395211793736, 972.3825370889465, 973.6981535723913, 975.8194733974202, 978.3885071830106, 982.2731178927578, 987.5950860147341, 987.6839411388358, 992.1219720547296, 995.9502024898762, 1038.942858142802, 1040.9895901041007, 1045.0229035851503, 1045.9110975567048, 1045.9320144190642, 953.3850666320254, 977.9608815647366, 1038.729930218145, 1039.7816458543714, 1040.011988610819, 753.1263734068455, 756.8032311598969, 756.9016027916391, 757.01209921053, 758.1395116542764, 16734.995900246024, 16810.159492025472, 16837.494875153767, 16849.578760530963, 16918.238679259463, 17458.738118928228, 18849.151788169565, 19017.80982190174, 19053.80946190534, 19088.90455547727, 14006.369713362923, 14452.638684032878, 14478.92760536201, 14560.708785824225, 14580.562583122417, 3440.673136052071, 3475.9652403475893, 3478.843452044639, 3487.9128021799406, 3494.1264683829045, 76937.61531192309, 79151.604241979, 79910.6004469974, 80472.0, 81013.59493202555, 14460.349284282232, 14460.710785784226, 14741.0, 14749.262536873113, 15159.09045457254, 25490.0, 25841.353966150997, 25945.481090378464, 25963.610545841828, 26028.86985565098, 7924.722634707758, 8161.673533058611, 8171.223733745284, 8171.468854524437, 8241.711540096068, 3922.7057970652313, 3975.2447035063246, 4019.336809426412, 4025.1144748155943, 4030.7783071931326, 4183.247015537232, 4316.848910288188, 4320.65434765218, 4326.762028088422, 4664.906701865943, 981.7889153831818, 984.3601658921615, 996.1084829077935, 996.277698668474, 997.3965750720854, 672.831792051987, 683.1835956032494, 689.0319101662172, 714.2250658036089, 718.2207305073949, 11413.372264525531, 11819.586314478953, 12023.819642705366, 12270.263784172977, 12795.232286062866, 659.6306068601599, 685.348918527391, 685.5030103175158, 696.7352406085655, 703.7536862098327, 5207.765650545734, 5373.193921094019, 5440.156775699773, 5503.11950087984, 5559.6664200148125, 89114.21957541227, 89815.0, 90287.0, 90835.54582227046, 92363.0, 56270.71864640651, 75702.0, 77410.22589774143, 79743.20256797358, 79807.0, 58738.0, 65794.34205657979, 66258.0, 68174.0, 69612.0, 11108.722281943015, 12349.19730217533, 12388.0, 12436.56472023511, 12641.810372844231, 28709.712902870702, 30554.0, 30659.0, 30916.0, 31515.21211969719, 36908.81545592255, 37846.0, 39160.0, 39732.0, 40068.1986360277, 15698.136602486516, 15762.448314308944, 15849.841501585297, 16266.755998659793, 16271.3491460345, 16993.91503042477, 17537.298508059535, 17682.115894205497, 17725.822741772416, 17754.822451775835, 15795.526134215992, 16114.838851611334, 16578.336866525206, 17025.40411085606, 17142.0, 16004.19979001022, 16030.599235018752, 16143.273552690393, 16261.51215463538, 16428.096454695107, 15935.203239838194, 16174.353025878832, 16301.59246018859, 16447.342106315613, 16583.751243731596, 8928.910710893068, 9504.809903802023, 9916.851247231441, 9933.801323973625, 9938.403695778277, 11254.60608878718, 11318.434078296217, 11608.477618507357, 11646.592369267035, 11681.299122052704], "value": 7934.999331200018, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 111.0, 109.0, 114.0, 111.0, 111.0, 111.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 120.0, 148.0, 176.0, 124.0, 152.0, 148.0, 123.0, 175.0, 124.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 162.0, 165.0, 167.0, 169.0, 171.0, 179.0, 165.0], "value": 166.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 165.0, 75.0, 75.0, 76.0, 75.0, 99.0, 74.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 142.0, 83.0, 86.0, 82.0, 132.0, 84.0, 84.0, 135.0], "value": 99.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 115.0, 114.0, 114.0, 115.0, 117.0, 117.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 150.0, 152.0, 151.0, 151.0, 151.0, 150.0, 150.0, 152.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 94.0, 96.0, 94.0, 96.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0, 56.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 57.0, 56.0, 56.0, 58.0, 58.0, 59.0, 56.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 86.0, 82.0, 78.0, 82.0, 78.0, 78.0, 78.0, 78.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 128.0, 130.0, 140.0, 139.0, 136.0, 129.0, 131.0, 126.0, 155.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 191.0, 193.0, 193.0, 193.0, 191.0, 194.0, 197.0, 190.0, 184.0], "value": 191.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 75.0, 74.0, 74.0, 71.0, 72.0, 75.0, 72.0], "value": 73.6, "unit": "score"}]}]} 02:37:37 INFO - Return code: 0 02:37:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:37:37 INFO - # TBPL SUCCESS # 02:37:37 INFO - Running post-action listener: _resource_record_post_action 02:37:37 INFO - [mozharness: 2017-06-11 09:37:37.725013Z] Finished run-tests step (success) 02:37:37 INFO - Running post-run listener: _resource_record_post_run 02:37:37 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 8716288; Write bytes: 440602624; Read time: 2804; Write time: 342236 02:37:37 INFO - TinderboxPrint: CPU usage
12.6% 02:37:37 INFO - TinderboxPrint: I/O read bytes / time
8,716,288 / 2,804 02:37:37 INFO - TinderboxPrint: I/O write bytes / time
440,602,624 / 342,236 02:37:37 INFO - TinderboxPrint: CPU idle
8,745.7 (87.4%) 02:37:37 INFO - TinderboxPrint: CPU user
1,209.4 (12.1%) 02:37:37 INFO - TinderboxPrint: Swap in / out
0 / 0 02:37:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 8192; Write bytes: 118878208; Read time: 236; Write time: 81824 02:37:37 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:37:37 INFO - run-tests - Wall time: 1237s; CPU: 13.0%; Read bytes: 6672384; Write bytes: 228790272; Read time: 2200; Write time: 181444 02:37:38 INFO - Running post-run listener: _upload_blobber_files 02:37:38 INFO - Blob upload gear active. 02:37:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:37:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:37:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:37:38 INFO - (blobuploader) - INFO - Open directory for files ... 02:37:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:37:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:37:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:37:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:37:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:37:39 INFO - (blobuploader) - INFO - Done attempting. 02:37:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:37:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:37:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:37:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:37:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:37:41 INFO - (blobuploader) - INFO - Done attempting. 02:37:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:37:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:37:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:37:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:37:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:37:42 INFO - (blobuploader) - INFO - Done attempting. 02:37:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:37:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:37:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:37:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:37:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:37:49 INFO - (blobuploader) - INFO - Done attempting. 02:37:49 INFO - (blobuploader) - INFO - Iteration through files over. 02:37:49 INFO - Return code: 0 02:37:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:37:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:37:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e8b16ff4b71ec87672d09fcc2c2346551cc8540d0b37c7b9a1756b323d66c1e1e1e1824abc1d3e9d1be5d16cd98895198c82c8cda0d5184aeab0f56c982cb73", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7774a0d02e076905e0c8f9cd41608fc445c574c7f2016f0644771e999906336231d8bfae85f35fee84054dcc9bba6fa134a928c1fe2884416b01086aefcc9b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23495e97fe29c310d8c0f1d9b9bd711ff25db4ea95a378ecbcf2f84aa4e8631b82a142980b7ccb93ae95a1e4ba5801f3a8f6d0aea2f864aa3bcc75685ac276ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa2ede09244c9695c6bb97af17bf76c56a92873fc26e2cdbbf7ddbdbaf04806e2a92b2704a551d3af094ea3e6fbca28924dc9d1ab9596d70fce06f87a70fb1d3"} 02:37:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:37:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:37:49 INFO - Contents: 02:37:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e8b16ff4b71ec87672d09fcc2c2346551cc8540d0b37c7b9a1756b323d66c1e1e1e1824abc1d3e9d1be5d16cd98895198c82c8cda0d5184aeab0f56c982cb73", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7774a0d02e076905e0c8f9cd41608fc445c574c7f2016f0644771e999906336231d8bfae85f35fee84054dcc9bba6fa134a928c1fe2884416b01086aefcc9b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23495e97fe29c310d8c0f1d9b9bd711ff25db4ea95a378ecbcf2f84aa4e8631b82a142980b7ccb93ae95a1e4ba5801f3a8f6d0aea2f864aa3bcc75685ac276ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa2ede09244c9695c6bb97af17bf76c56a92873fc26e2cdbbf7ddbdbaf04806e2a92b2704a551d3af094ea3e6fbca28924dc9d1ab9596d70fce06f87a70fb1d3"} 02:37:49 INFO - Running post-run listener: copy_logs_to_upload_dir 02:37:49 INFO - Copying logs to upload dir... 02:37:49 INFO - mkdir: /builds/slave/test/build/upload/logs 02:37:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1319.023928 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2017-06-11 02:37:49.217468) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-11 02:37:49.223828) ========= 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=0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e8b16ff4b71ec87672d09fcc2c2346551cc8540d0b37c7b9a1756b323d66c1e1e1e1824abc1d3e9d1be5d16cd98895198c82c8cda0d5184aeab0f56c982cb73", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7774a0d02e076905e0c8f9cd41608fc445c574c7f2016f0644771e999906336231d8bfae85f35fee84054dcc9bba6fa134a928c1fe2884416b01086aefcc9b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23495e97fe29c310d8c0f1d9b9bd711ff25db4ea95a378ecbcf2f84aa4e8631b82a142980b7ccb93ae95a1e4ba5801f3a8f6d0aea2f864aa3bcc75685ac276ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa2ede09244c9695c6bb97af17bf76c56a92873fc26e2cdbbf7ddbdbaf04806e2a92b2704a551d3af094ea3e6fbca28924dc9d1ab9596d70fce06f87a70fb1d3"} build_url:https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011354 build_url: 'https://queue.taskcluster.net/v1/task/YW3tuiWxRdOdlOvy6x92Rw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e8b16ff4b71ec87672d09fcc2c2346551cc8540d0b37c7b9a1756b323d66c1e1e1e1824abc1d3e9d1be5d16cd98895198c82c8cda0d5184aeab0f56c982cb73", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b7774a0d02e076905e0c8f9cd41608fc445c574c7f2016f0644771e999906336231d8bfae85f35fee84054dcc9bba6fa134a928c1fe2884416b01086aefcc9b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23495e97fe29c310d8c0f1d9b9bd711ff25db4ea95a378ecbcf2f84aa4e8631b82a142980b7ccb93ae95a1e4ba5801f3a8f6d0aea2f864aa3bcc75685ac276ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa2ede09244c9695c6bb97af17bf76c56a92873fc26e2cdbbf7ddbdbaf04806e2a92b2704a551d3af094ea3e6fbca28924dc9d1ab9596d70fce06f87a70fb1d3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-11 02:37:49.250699) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:37:49.251004) ========= 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=0333a256a5e4f052382dd180000001b1-1497159726.403233-104503442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-11 02:37:49.333083) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-11 02:37:49.336421) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-11 02:37:49.336701) ========= ========= Total master_lag: 0.28 =========