builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-080 starttime: 1497268898.1 results: success (0) revision: f9605772a0c9098ed1bcaa98089b2c944ed69e9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:38.102995) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:38.103496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:38.103858) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:38.124718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:38.125013) ========= 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=781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-12 05:01:38-- 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% 111M=0s 2017-06-12 05:01:38 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153276 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:38.292609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:38.292899) ========= 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=781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019056 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:38.344734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-12 05:01:38.345072) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f9605772a0c9098ed1bcaa98089b2c944ed69e9b --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 f9605772a0c9098ed1bcaa98089b2c944ed69e9b --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=781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-12 05:01:38,430 truncating revision to first 12 chars 2017-06-12 05:01:38,430 Setting DEBUG logging. 2017-06-12 05:01:38,430 attempt 1/10 2017-06-12 05:01:38,430 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f9605772a0c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-12 05:01:39,730 unpacking tar archive at: mozilla-central-f9605772a0c9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.596240 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-12 05:01:39.955172) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:39.955592) ========= script_repo_revision: f9605772a0c9098ed1bcaa98089b2c944ed69e9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:39.955992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:39.956251) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-12 05:01:39.966109) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-12 05:01:39.966494) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:01:40 INFO - MultiFileLogger online at 20170612 05:01:40 in /builds/slave/test 05:01:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:01:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:01:40 INFO - {'append_to_log': False, 05:01:40 INFO - 'base_work_dir': '/builds/slave/test', 05:01:40 INFO - 'blob_upload_branch': 'Firefox', 05:01:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:01:40 INFO - 'branch': 'Firefox', 05:01:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:01:40 INFO - 'config_files': ('talos/linux_config.py',), 05:01:40 INFO - 'default_actions': ('clobber', 05:01:40 INFO - 'read-buildbot-config', 05:01:40 INFO - 'download-and-extract', 05:01:40 INFO - 'populate-webroot', 05:01:40 INFO - 'create-virtualenv', 05:01:40 INFO - 'install', 05:01:40 INFO - 'setup-mitmproxy', 05:01:40 INFO - 'run-tests'), 05:01:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:01:40 INFO - 'download_minidump_stackwalk': True, 05:01:40 INFO - 'download_symbols': 'ondemand', 05:01:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:01:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:01:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:01:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:01:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:01:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:01:40 INFO - 'gecko_profile': False, 05:01:40 INFO - 'gecko_profile_interval': 0, 05:01:40 INFO - 'installer_path': 'installer.exe', 05:01:40 INFO - 'log_level': 'info', 05:01:40 INFO - 'log_name': 'talos', 05:01:40 INFO - 'log_to_console': True, 05:01:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:01:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:01:40 INFO - 'opt_config_files': (), 05:01:40 INFO - 'pip_index': False, 05:01:40 INFO - 'suite': 'dromaeojs-e10s', 05:01:40 INFO - 'system_bits': '32', 05:01:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:01:40 INFO - 'title': 'talos-linux64-ix-080', 05:01:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:01:40 INFO - 'use_talos_json': True, 05:01:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:01:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:01:40 INFO - 'work_dir': 'build'} 05:01:40 INFO - [mozharness: 2017-06-12 12:01:40.150308Z] Running clobber step. 05:01:40 INFO - Running pre-action listener: _resource_record_pre_action 05:01:40 INFO - Running main action method: clobber 05:01:40 INFO - rmtree: /builds/slave/test/build 05:01:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:01:41 INFO - Running post-action listener: _resource_record_post_action 05:01:41 INFO - [mozharness: 2017-06-12 12:01:41.179336Z] Finished clobber step (success) 05:01:41 INFO - [mozharness: 2017-06-12 12:01:41.179438Z] Running read-buildbot-config step. 05:01:41 INFO - Running pre-action listener: _resource_record_pre_action 05:01:41 INFO - Running main action method: read_buildbot_config 05:01:41 INFO - Using buildbot properties: 05:01:41 INFO - { 05:01:41 INFO - "project": "", 05:01:41 INFO - "product": "firefox", 05:01:41 INFO - "who": "cbook@mozilla.com", 05:01:41 INFO - "installer_path": "public/build/target.tar.bz2", 05:01:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 05:01:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:01:41 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 05:01:41 INFO - "stage_platform": "linux64-stylo", 05:01:41 INFO - "basedir": "/builds/slave/test", 05:01:41 INFO - "buildnumber": 145, 05:01:41 INFO - "platform": "ubuntu64_hw_stylo", 05:01:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:01:41 INFO - "slavebuilddir": "test", 05:01:41 INFO - "taskId": "RASL_xchS9GUxVCjTtZFZw", 05:01:41 INFO - "branch": "mozilla-central", 05:01:41 INFO - "script_repo_revision": "production", 05:01:41 INFO - "revision": "f9605772a0c9098ed1bcaa98089b2c944ed69e9b", 05:01:41 INFO - "slavename": "talos-linux64-ix-080", 05:01:41 INFO - "repo_path": "mozilla-central" 05:01:41 INFO - } 05:01:41 INFO - Finding installer, test and symbols from parent task. 05:01:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RASL_xchS9GUxVCjTtZFZw'}, attempt #1 05:01:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RASL_xchS9GUxVCjTtZFZw'}, attempt #1 05:01:42 INFO - Task dependencies: QfHtqPEXTuOQ4r-A0GCs0w 05:01:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w'}, attempt #1 05:01:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2 05:01:42 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/test_packages.json 05:01:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.crashreporter-symbols.zip 05:01:42 INFO - Running post-action listener: _resource_record_post_action 05:01:42 INFO - [mozharness: 2017-06-12 12:01:42.535004Z] Finished read-buildbot-config step (success) 05:01:42 INFO - [mozharness: 2017-06-12 12:01:42.535225Z] Running download-and-extract step. 05:01:42 INFO - Running pre-action listener: _resource_record_pre_action 05:01:42 INFO - Running main action method: download_and_extract 05:01:42 INFO - mkdir: /builds/slave/test/build/tests 05:01:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:42 INFO - trying https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.test_packages.json 05:01:42 INFO - Downloading https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:01:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:01:43 INFO - Downloaded 989 bytes. 05:01:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:01:43 INFO - Using the following test package requirements: 05:01:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:01:43 INFO - u'common': [u'target.common.tests.zip'], 05:01:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:01:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:01:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:01:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:01:43 INFO - u'mozbase': [u'target.common.tests.zip'], 05:01:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:01:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:01:43 INFO - u'web-platform': [u'target.common.tests.zip', 05:01:43 INFO - u'target.web-platform.tests.tar.gz'], 05:01:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:01:43 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:01:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.common.tests.zip 05:01:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:01:43 INFO - Fetch https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.common.tests.zip into memory 05:01:44 INFO - Content-Length response header: 67876989 05:01:44 INFO - Bytes received: 67876989 05:01:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:01:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.common.tests.zip 05:01:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:01:55 INFO - Fetch https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.common.tests.zip into memory 05:01:57 INFO - Content-Length response header: 67876989 05:01:57 INFO - Bytes received: 67876989 05:02:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.talos.tests.zip 05:02:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:02:11 INFO - Fetch https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.talos.tests.zip into memory 05:02:12 INFO - Content-Length response header: 14450010 05:02:12 INFO - Bytes received: 14450010 05:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:12 INFO - trying https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2 05:02:12 INFO - Downloading https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:02:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:02:13 INFO - Downloaded 61471682 bytes. 05:02:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2 05:02:13 INFO - mkdir: /builds/slave/test/properties 05:02:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:02:13 INFO - Writing to file /builds/slave/test/properties/build_url 05:02:13 INFO - Contents: 05:02:13 INFO - build_url:https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2 05:02:13 INFO - Running post-action listener: _resource_record_post_action 05:02:13 INFO - Running post-action listener: set_extra_try_arguments 05:02:13 INFO - [mozharness: 2017-06-12 12:02:13.436874Z] Finished download-and-extract step (success) 05:02:13 INFO - [mozharness: 2017-06-12 12:02:13.436970Z] Running populate-webroot step. 05:02:13 INFO - Running pre-action listener: _resource_record_pre_action 05:02:13 INFO - Running main action method: populate_webroot 05:02:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:02:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:02:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:02:13 INFO - '--tppagecycles', 05:02:13 INFO - '7'], 05:02:13 INFO - 'tests': ['tsvgm']}}, 05:02:13 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:02:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:02:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:02:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:02:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:02:13 INFO - 'talos_options': ['--disable-e10s'], 05:02:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:02:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:02:13 INFO - 'talos_options': ['--disable-e10s'], 05:02:13 INFO - 'tests': ['damp', 'tps']}, 05:02:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:02:13 INFO - 'tests': ['damp', 'tps']}, 05:02:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:02:13 INFO - 'tests': ['dromaeo_dom']}, 05:02:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:02:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:02:13 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:02:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:02:13 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:02:13 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:02:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:02:13 INFO - 'tests': ['a11yr', 05:02:13 INFO - 'ts_paint', 05:02:13 INFO - 'tpaint', 05:02:13 INFO - 'sessionrestore', 05:02:13 INFO - 'sessionrestore_no_auto_restore', 05:02:13 INFO - 'tabpaint']}, 05:02:13 INFO - 'other-e10s': {'tests': ['a11yr', 05:02:13 INFO - 'ts_paint', 05:02:13 INFO - 'tpaint', 05:02:13 INFO - 'sessionrestore', 05:02:13 INFO - 'sessionrestore_no_auto_restore', 05:02:13 INFO - 'tabpaint']}, 05:02:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:02:13 INFO - 'ts_paint', 05:02:13 INFO - 'tpaint', 05:02:13 INFO - 'sessionrestore', 05:02:13 INFO - 'sessionrestore_no_auto_restore', 05:02:13 INFO - 'tabpaint']}, 05:02:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:02:13 INFO - 'ts_paint', 05:02:13 INFO - 'tpaint', 05:02:13 INFO - 'sessionrestore', 05:02:13 INFO - 'sessionrestore_no_auto_restore', 05:02:13 INFO - 'tabpaint']}, 05:02:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:02:13 INFO - 'tests': ['a11yr', 05:02:13 INFO - 'ts_paint', 05:02:13 INFO - 'tpaint', 05:02:13 INFO - 'sessionrestore', 05:02:13 INFO - 'sessionrestore_no_auto_restore', 05:02:13 INFO - 'tabpaint']}, 05:02:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:02:13 INFO - 'tests': ['a11yr', 05:02:13 INFO - 'ts_paint', 05:02:13 INFO - 'tpaint', 05:02:13 INFO - 'sessionrestore', 05:02:13 INFO - 'sessionrestore_no_auto_restore', 05:02:13 INFO - 'tabpaint']}, 05:02:13 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:02:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:02:13 INFO - 'bloom_basic_ref']}, 05:02:13 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:02:13 INFO - 'talos_options': ['--mitmproxy', 05:02:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:02:13 INFO - '--firstNonBlankPaint'], 05:02:13 INFO - 'tests': ['quantum_pageload_google', 05:02:13 INFO - 'quantum_pageload_youtube', 05:02:13 INFO - 'quantum_pageload_amazon', 05:02:13 INFO - 'quantum_pageload_facebook']}, 05:02:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:02:13 INFO - 'tests': ['tsvgx', 05:02:13 INFO - 'tsvgr_opacity', 05:02:13 INFO - 'tart', 05:02:13 INFO - 'tscrollx', 05:02:13 INFO - 'cart', 05:02:13 INFO - 'tsvg_static']}, 05:02:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:02:13 INFO - 'tsvgr_opacity', 05:02:13 INFO - 'tart', 05:02:13 INFO - 'tscrollx', 05:02:13 INFO - 'cart', 05:02:13 INFO - 'tsvg_static']}, 05:02:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:02:13 INFO - 'talos_options': ['--disable-e10s'], 05:02:13 INFO - 'tests': ['tp5o']}, 05:02:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:02:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:02:13 INFO - 'talos_options': ['--disable-e10s', 05:02:13 INFO - '--xperf_path', 05:02:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:13 INFO - 'tests': ['tp5n']}, 05:02:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:02:13 INFO - 'talos_options': ['--xperf_path', 05:02:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:13 INFO - 'tests': ['tp5n']}}, 05:02:13 INFO - 'talos.zip': {'path': '', 05:02:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:02:13 INFO - Running post-action listener: _resource_record_post_action 05:02:13 INFO - [mozharness: 2017-06-12 12:02:13.451846Z] Finished populate-webroot step (success) 05:02:13 INFO - [mozharness: 2017-06-12 12:02:13.451935Z] Running create-virtualenv step. 05:02:13 INFO - Running pre-action listener: _resource_record_pre_action 05:02:13 INFO - Running main action method: create_virtualenv 05:02:13 INFO - Creating virtualenv /builds/slave/test/build/venv 05:02:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:02:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:02:13 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:02:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:02:13 INFO - Using real prefix '/usr' 05:02:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:02:14 INFO - Installing distribute.............................................................................................................................................................................................done. 05:02:16 INFO - Installing pip.................done. 05:02:16 INFO - Return code: 0 05:02:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:02:16 INFO - Reading from file tmpfile_stdout 05:02:16 INFO - Output received: 05:02:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:02:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:16 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 0xdf93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175140>, '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 0x1175a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1175ed0>, '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': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:02:16 INFO - Using env: {'DISPLAY': ':0', 05:02:16 INFO - 'HOME': '/home/cltbld', 05:02:16 INFO - 'LANG': 'en_US.UTF-8', 05:02:16 INFO - 'LANGUAGE': 'en_US:en', 05:02:16 INFO - 'LOGNAME': 'cltbld', 05:02:16 INFO - 'MAIL': '/var/mail/cltbld', 05:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:16 INFO - 'MOZ_NO_REMOTE': '1', 05:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:16 INFO - 'NO_EM_RESTART': '1', 05:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:16 INFO - 'PWD': '/builds/slave/test', 05:02:16 INFO - 'SHELL': '/bin/bash', 05:02:16 INFO - 'SHLVL': '1', 05:02:16 INFO - 'TERM': 'linux', 05:02:16 INFO - 'TMOUT': '86400', 05:02:16 INFO - 'USER': 'cltbld', 05:02:16 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 05:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:16 INFO - '_': '/tools/buildbot/bin/python'} 05:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:02:16 INFO - Cleaning up... 05:02:16 INFO - Return code: 0 05:02:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:16 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 0xdf93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175140>, '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 0x1175a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1175ed0>, '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': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:02:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:02:16 INFO - Using env: {'DISPLAY': ':0', 05:02:16 INFO - 'HOME': '/home/cltbld', 05:02:16 INFO - 'LANG': 'en_US.UTF-8', 05:02:16 INFO - 'LANGUAGE': 'en_US:en', 05:02:16 INFO - 'LOGNAME': 'cltbld', 05:02:16 INFO - 'MAIL': '/var/mail/cltbld', 05:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:16 INFO - 'MOZ_NO_REMOTE': '1', 05:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:16 INFO - 'NO_EM_RESTART': '1', 05:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:16 INFO - 'PWD': '/builds/slave/test', 05:02:16 INFO - 'SHELL': '/bin/bash', 05:02:16 INFO - 'SHLVL': '1', 05:02:16 INFO - 'TERM': 'linux', 05:02:16 INFO - 'TMOUT': '86400', 05:02:16 INFO - 'USER': 'cltbld', 05:02:16 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 05:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:16 INFO - '_': '/tools/buildbot/bin/python'} 05:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:16 INFO - Downloading/unpacking psutil>=3.1.1 05:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:02:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:17 INFO - Installing collected packages: psutil 05:02:17 INFO - Running setup.py install for psutil 05:02:17 INFO - building 'psutil._psutil_linux' extension 05:02:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:02:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:02:18 INFO - building 'psutil._psutil_posix' extension 05:02:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:02:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:02:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:18 INFO - Successfully installed psutil 05:02:18 INFO - Cleaning up... 05:02:18 INFO - Return code: 0 05:02:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:18 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 0xdf93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175140>, '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 0x1175a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1175ed0>, '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': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:02:18 INFO - Using env: {'DISPLAY': ':0', 05:02:18 INFO - 'HOME': '/home/cltbld', 05:02:18 INFO - 'LANG': 'en_US.UTF-8', 05:02:18 INFO - 'LANGUAGE': 'en_US:en', 05:02:18 INFO - 'LOGNAME': 'cltbld', 05:02:18 INFO - 'MAIL': '/var/mail/cltbld', 05:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:18 INFO - 'MOZ_NO_REMOTE': '1', 05:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:18 INFO - 'NO_EM_RESTART': '1', 05:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:18 INFO - 'PWD': '/builds/slave/test', 05:02:18 INFO - 'SHELL': '/bin/bash', 05:02:18 INFO - 'SHLVL': '1', 05:02:18 INFO - 'TERM': 'linux', 05:02:18 INFO - 'TMOUT': '86400', 05:02:18 INFO - 'USER': 'cltbld', 05:02:18 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 05:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:18 INFO - '_': '/tools/buildbot/bin/python'} 05:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:02:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:02:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:02:19 INFO - Installing collected packages: mozsystemmonitor 05:02:19 INFO - Running setup.py install for mozsystemmonitor 05:02:20 INFO - Successfully installed mozsystemmonitor 05:02:20 INFO - Cleaning up... 05:02:20 INFO - Return code: 0 05:02:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:20 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 0xdf93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175140>, '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 0x1175a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1175ed0>, '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': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:02:20 INFO - Using env: {'DISPLAY': ':0', 05:02:20 INFO - 'HOME': '/home/cltbld', 05:02:20 INFO - 'LANG': 'en_US.UTF-8', 05:02:20 INFO - 'LANGUAGE': 'en_US:en', 05:02:20 INFO - 'LOGNAME': 'cltbld', 05:02:20 INFO - 'MAIL': '/var/mail/cltbld', 05:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:20 INFO - 'MOZ_NO_REMOTE': '1', 05:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:20 INFO - 'NO_EM_RESTART': '1', 05:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:20 INFO - 'PWD': '/builds/slave/test', 05:02:20 INFO - 'SHELL': '/bin/bash', 05:02:20 INFO - 'SHLVL': '1', 05:02:20 INFO - 'TERM': 'linux', 05:02:20 INFO - 'TMOUT': '86400', 05:02:20 INFO - 'USER': 'cltbld', 05:02:20 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 05:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:20 INFO - '_': '/tools/buildbot/bin/python'} 05:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:20 INFO - Downloading/unpacking jsonschema==2.5.1 05:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:21 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:21 INFO - warning: no files found matching '*.txt' 05:02:21 INFO - no previously-included directories found matching 'build' 05:02:21 INFO - no previously-included directories found matching 'dist' 05:02:21 INFO - no previously-included directories found matching '.git*' 05:02:21 INFO - Installing collected packages: jsonschema, functools32 05:02:21 INFO - Running setup.py install for functools32 05:02:21 INFO - warning: no files found matching '*.txt' 05:02:21 INFO - no previously-included directories found matching 'build' 05:02:21 INFO - no previously-included directories found matching 'dist' 05:02:21 INFO - no previously-included directories found matching '.git*' 05:02:21 INFO - Successfully installed jsonschema functools32 05:02:21 INFO - Cleaning up... 05:02:21 INFO - Return code: 0 05:02:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02: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')]} 05:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:21 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 0xdf93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175140>, '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 0x1175a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1175ed0>, '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': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:02:21 INFO - Using env: {'DISPLAY': ':0', 05:02:21 INFO - 'HOME': '/home/cltbld', 05:02:21 INFO - 'LANG': 'en_US.UTF-8', 05:02:21 INFO - 'LANGUAGE': 'en_US:en', 05:02:21 INFO - 'LOGNAME': 'cltbld', 05:02:21 INFO - 'MAIL': '/var/mail/cltbld', 05:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:21 INFO - 'MOZ_NO_REMOTE': '1', 05:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:21 INFO - 'NO_EM_RESTART': '1', 05:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:21 INFO - 'PWD': '/builds/slave/test', 05:02:21 INFO - 'SHELL': '/bin/bash', 05:02:21 INFO - 'SHLVL': '1', 05:02:21 INFO - 'TERM': 'linux', 05:02:21 INFO - 'TMOUT': '86400', 05:02:21 INFO - 'USER': 'cltbld', 05:02:21 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 05:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:21 INFO - '_': '/tools/buildbot/bin/python'} 05:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:02:21 INFO - Cleaning up... 05:02:21 INFO - Return code: 0 05:02:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02: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')]} 05:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:21 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 0xdf93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175140>, '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 0x1175a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1175ed0>, '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': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:02:21 INFO - Using env: {'DISPLAY': ':0', 05:02:21 INFO - 'HOME': '/home/cltbld', 05:02:21 INFO - 'LANG': 'en_US.UTF-8', 05:02:21 INFO - 'LANGUAGE': 'en_US:en', 05:02:21 INFO - 'LOGNAME': 'cltbld', 05:02:21 INFO - 'MAIL': '/var/mail/cltbld', 05:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:21 INFO - 'MOZ_NO_REMOTE': '1', 05:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:21 INFO - 'NO_EM_RESTART': '1', 05:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:21 INFO - 'PWD': '/builds/slave/test', 05:02:21 INFO - 'SHELL': '/bin/bash', 05:02:21 INFO - 'SHLVL': '1', 05:02:21 INFO - 'TERM': 'linux', 05:02:21 INFO - 'TMOUT': '86400', 05:02:21 INFO - 'USER': 'cltbld', 05:02:21 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 05:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:21 INFO - '_': '/tools/buildbot/bin/python'} 05:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:22 INFO - Downloading/unpacking blobuploader==1.2.4 05:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:23 INFO - Downloading blobuploader-1.2.4.tar.gz 05:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:02:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:02:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:23 INFO - Downloading docopt-0.6.1.tar.gz 05:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:02:23 INFO - Installing collected packages: blobuploader, requests, docopt 05:02:23 INFO - Running setup.py install for blobuploader 05:02:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:02:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:02:23 INFO - Running setup.py install for requests 05:02:24 INFO - Running setup.py install for docopt 05:02:24 INFO - Successfully installed blobuploader requests docopt 05:02:24 INFO - Cleaning up... 05:02:24 INFO - Return code: 0 05:02:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:24 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 0xdf93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175140>, '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 0x1175a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1175ed0>, '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': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:02:24 INFO - Using env: {'DISPLAY': ':0', 05:02:24 INFO - 'HOME': '/home/cltbld', 05:02:24 INFO - 'LANG': 'en_US.UTF-8', 05:02:24 INFO - 'LANGUAGE': 'en_US:en', 05:02:24 INFO - 'LOGNAME': 'cltbld', 05:02:24 INFO - 'MAIL': '/var/mail/cltbld', 05:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:24 INFO - 'MOZ_NO_REMOTE': '1', 05:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:24 INFO - 'NO_EM_RESTART': '1', 05:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:24 INFO - 'PWD': '/builds/slave/test', 05:02:24 INFO - 'SHELL': '/bin/bash', 05:02:24 INFO - 'SHLVL': '1', 05:02:24 INFO - 'TERM': 'linux', 05:02:24 INFO - 'TMOUT': '86400', 05:02:24 INFO - 'USER': 'cltbld', 05:02:24 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 05:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:24 INFO - '_': '/tools/buildbot/bin/python'} 05:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:24 INFO - Running setup.py (path:/tmp/pip-Y7WJzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:24 INFO - Running setup.py (path:/tmp/pip-YTHUq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:24 INFO - Running setup.py (path:/tmp/pip-mN8EvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:24 INFO - Running setup.py (path:/tmp/pip-xihA6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:24 INFO - Running setup.py (path:/tmp/pip-RqOqBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:25 INFO - Running setup.py (path:/tmp/pip-SXgvtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:25 INFO - Running setup.py (path:/tmp/pip-DQKc78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:25 INFO - Running setup.py (path:/tmp/pip-gVp8_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:25 INFO - Running setup.py (path:/tmp/pip-rqFwbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:25 INFO - Running setup.py (path:/tmp/pip-04WWV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:25 INFO - Running setup.py (path:/tmp/pip-8s00dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:25 INFO - Running setup.py (path:/tmp/pip-_HlCmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:25 INFO - Running setup.py (path:/tmp/pip-xqRaqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:25 INFO - Running setup.py (path:/tmp/pip-lQqN9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:25 INFO - Running setup.py (path:/tmp/pip-amB2Bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:25 INFO - Running setup.py (path:/tmp/pip-l8FMtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:25 INFO - Running setup.py (path:/tmp/pip-DtPiFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:02:25 INFO - Running setup.py install for manifestparser 05:02:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Running setup.py install for mozcrash 05:02:26 INFO - Running setup.py install for mozdebug 05:02:26 INFO - Running setup.py install for mozdevice 05:02:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Running setup.py install for mozfile 05:02:26 INFO - Running setup.py install for mozhttpd 05:02:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Running setup.py install for mozinfo 05:02:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Running setup.py install for mozInstall 05:02:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Running setup.py install for mozleak 05:02:26 INFO - Running setup.py install for mozlog 05:02:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:02:26 INFO - Running setup.py install for moznetwork 05:02:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:02:27 INFO - Running setup.py install for mozprocess 05:02:27 INFO - Running setup.py install for mozprofile 05:02:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:02:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:02:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:02:27 INFO - Running setup.py install for mozrunner 05:02:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:02:27 INFO - Running setup.py install for mozscreenshot 05:02:27 INFO - Running setup.py install for moztest 05:02:27 INFO - Running setup.py install for mozversion 05:02:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:02:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:02:27 INFO - Cleaning up... 05:02:27 INFO - Return code: 0 05:02:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:27 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 0xdf93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175140>, '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 0x1175a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1175ed0>, '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': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:02:27 INFO - Using env: {'DISPLAY': ':0', 05:02:27 INFO - 'HOME': '/home/cltbld', 05:02:27 INFO - 'LANG': 'en_US.UTF-8', 05:02:27 INFO - 'LANGUAGE': 'en_US:en', 05:02:27 INFO - 'LOGNAME': 'cltbld', 05:02:27 INFO - 'MAIL': '/var/mail/cltbld', 05:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:27 INFO - 'MOZ_NO_REMOTE': '1', 05:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:27 INFO - 'NO_EM_RESTART': '1', 05:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:27 INFO - 'PWD': '/builds/slave/test', 05:02:27 INFO - 'SHELL': '/bin/bash', 05:02:27 INFO - 'SHLVL': '1', 05:02:27 INFO - 'TERM': 'linux', 05:02:27 INFO - 'TMOUT': '86400', 05:02:27 INFO - 'USER': 'cltbld', 05:02:27 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 05:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:27 INFO - '_': '/tools/buildbot/bin/python'} 05:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:27 INFO - Running setup.py (path:/tmp/pip-b_KaLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:27 INFO - Running setup.py (path:/tmp/pip-aezy9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:28 INFO - Running setup.py (path:/tmp/pip-dpzzS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:28 INFO - Running setup.py (path:/tmp/pip-_3hFY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:28 INFO - Running setup.py (path:/tmp/pip-WnNobK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:28 INFO - Running setup.py (path:/tmp/pip-i3mMZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:28 INFO - Running setup.py (path:/tmp/pip-0NZxAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:28 INFO - Running setup.py (path:/tmp/pip-j85fcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:28 INFO - Running setup.py (path:/tmp/pip-bcoKNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:28 INFO - Running setup.py (path:/tmp/pip-9rx0JJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:28 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)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:28 INFO - Running setup.py (path:/tmp/pip-TsiTq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:28 INFO - Running setup.py (path:/tmp/pip-7HV346-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:28 INFO - Running setup.py (path:/tmp/pip-3Hpeyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:28 INFO - Running setup.py (path:/tmp/pip-4ejMHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:28 INFO - Running setup.py (path:/tmp/pip-DcNaCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:28 INFO - Running setup.py (path:/tmp/pip-NDDPxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:29 INFO - Running setup.py (path:/tmp/pip-k_jL0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:02:29 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:02:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:02: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 05:02: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 05:02: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 05:02: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 05:02:30 INFO - Downloading blessings-1.6.tar.gz 05:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:02:30 INFO - Installing collected packages: blessings 05:02:30 INFO - Running setup.py install for blessings 05:02:30 INFO - Successfully installed blessings 05:02:30 INFO - Cleaning up... 05:02:30 INFO - Return code: 0 05:02:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:02:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:30 INFO - Reading from file tmpfile_stdout 05:02:30 INFO - Current package versions: 05:02:30 INFO - argparse == 1.2.1 05:02:30 INFO - blessings == 1.6 05:02:30 INFO - blobuploader == 1.2.4 05:02:30 INFO - docopt == 0.6.1 05:02:30 INFO - functools32 == 3.2.3-2 05:02:30 INFO - jsonschema == 2.5.1 05:02:30 INFO - manifestparser == 1.1 05:02:30 INFO - mozInstall == 1.13 05:02:30 INFO - mozcrash == 1.0 05:02:30 INFO - mozdebug == 0.1 05:02:30 INFO - mozdevice == 0.51 05:02:30 INFO - mozfile == 1.2 05:02:30 INFO - mozhttpd == 0.7 05:02:30 INFO - mozinfo == 0.10 05:02:30 INFO - mozleak == 0.1 05:02:30 INFO - mozlog == 3.4 05:02:30 INFO - moznetwork == 0.27 05:02:30 INFO - mozprocess == 0.25 05:02:30 INFO - mozprofile == 0.28 05:02:30 INFO - mozrunner == 6.13 05:02:30 INFO - mozscreenshot == 0.1 05:02:30 INFO - mozsystemmonitor == 0.3 05:02:30 INFO - moztest == 0.8 05:02:30 INFO - mozversion == 1.4 05:02:30 INFO - psutil == 3.1.1 05:02:30 INFO - requests == 1.2.3 05:02:30 INFO - wsgiref == 0.1.2 05:02:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02: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')]} 05:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:30 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 0xdf93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175140>, '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 0x1175a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1175ed0>, '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': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:02:30 INFO - Using env: {'DISPLAY': ':0', 05:02:30 INFO - 'HOME': '/home/cltbld', 05:02:30 INFO - 'LANG': 'en_US.UTF-8', 05:02:30 INFO - 'LANGUAGE': 'en_US:en', 05:02:30 INFO - 'LOGNAME': 'cltbld', 05:02:30 INFO - 'MAIL': '/var/mail/cltbld', 05:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:30 INFO - 'MOZ_NO_REMOTE': '1', 05:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:30 INFO - 'NO_EM_RESTART': '1', 05:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:30 INFO - 'PWD': '/builds/slave/test', 05:02:30 INFO - 'SHELL': '/bin/bash', 05:02:30 INFO - 'SHLVL': '1', 05:02:30 INFO - 'TERM': 'linux', 05:02:30 INFO - 'TMOUT': '86400', 05:02:30 INFO - 'USER': 'cltbld', 05:02:30 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 05:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:30 INFO - '_': '/tools/buildbot/bin/python'} 05:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:02:30 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:02: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 05:02: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 05:02: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 05:02: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 05:02:31 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:02:32 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)) 05:02:32 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)) 05:02:32 INFO - Installing collected packages: marionette-driver 05:02:32 INFO - Running setup.py install for marionette-driver 05:02:32 INFO - Successfully installed marionette-driver 05:02:32 INFO - Cleaning up... 05:02:32 INFO - Return code: 0 05:02:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02: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')]} 05:02:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdf93b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11779a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175140>, '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 0x1175a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1175ed0>, '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': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:02: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', 'jsonschema'] in /builds/slave/test/build 05:02: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 jsonschema 05:02:32 INFO - Using env: {'DISPLAY': ':0', 05:02:32 INFO - 'HOME': '/home/cltbld', 05:02:32 INFO - 'LANG': 'en_US.UTF-8', 05:02:32 INFO - 'LANGUAGE': 'en_US:en', 05:02:32 INFO - 'LOGNAME': 'cltbld', 05:02:32 INFO - 'MAIL': '/var/mail/cltbld', 05:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:32 INFO - 'MOZ_NO_REMOTE': '1', 05:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:32 INFO - 'NO_EM_RESTART': '1', 05:02:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:32 INFO - 'PWD': '/builds/slave/test', 05:02:32 INFO - 'SHELL': '/bin/bash', 05:02:32 INFO - 'SHLVL': '1', 05:02:32 INFO - 'TERM': 'linux', 05:02:32 INFO - 'TMOUT': '86400', 05:02:32 INFO - 'USER': 'cltbld', 05:02:32 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 05:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:32 INFO - '_': '/tools/buildbot/bin/python'} 05:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:02:32 INFO - Cleaning up... 05:02:32 INFO - Return code: 0 05:02:32 INFO - Running post-action listener: _resource_record_post_action 05:02:32 INFO - Running post-action listener: _start_resource_monitoring 05:02:32 INFO - Starting resource monitoring. 05:02:32 INFO - [mozharness: 2017-06-12 12:02:32.445301Z] Finished create-virtualenv step (success) 05:02:32 INFO - [mozharness: 2017-06-12 12:02:32.445804Z] Running install step. 05:02:32 INFO - Running pre-action listener: _resource_record_pre_action 05:02:32 INFO - Running main action method: install 05:02:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:32 INFO - Reading from file tmpfile_stdout 05:02:32 INFO - Detecting whether we're running mozinstall >=1.0... 05:02:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:02:32 INFO - Reading from file tmpfile_stdout 05:02:32 INFO - Output received: 05:02:32 INFO - Usage: mozinstall [options] installer 05:02:32 INFO - Options: 05:02:32 INFO - -h, --help show this help message and exit 05:02:32 INFO - -d DEST, --destination=DEST 05:02:32 INFO - Directory to install application into. [default: 05:02:32 INFO - "/builds/slave/test"] 05:02:32 INFO - --app=APP Application being installed. [default: firefox] 05:02:32 INFO - mkdir: /builds/slave/test/build/application 05:02:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:02:50 INFO - Reading from file tmpfile_stdout 05:02:50 INFO - Output received: 05:02:50 INFO - /builds/slave/test/build/application/firefox/firefox 05:02:50 INFO - Running post-action listener: _resource_record_post_action 05:02:50 INFO - [mozharness: 2017-06-12 12:02:50.596824Z] Finished install step (success) 05:02:50 INFO - [mozharness: 2017-06-12 12:02:50.596972Z] Running setup-mitmproxy step. 05:02:50 INFO - Running pre-action listener: _resource_record_pre_action 05:02:50 INFO - Running main action method: setup_mitmproxy 05:02:50 INFO - Skipping: mitmproxy is not required 05:02:50 INFO - Running post-action listener: _resource_record_post_action 05:02:50 INFO - [mozharness: 2017-06-12 12:02:50.597515Z] Finished setup-mitmproxy step (success) 05:02:50 INFO - [mozharness: 2017-06-12 12:02:50.597627Z] Running run-tests step. 05:02:50 INFO - Running pre-action listener: _resource_record_pre_action 05:02:50 INFO - Running main action method: run_tests 05:02:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:02:50 INFO - Python 2.7.3 05:02:50 INFO - Return code: 0 05:02:50 INFO - grabbing minidump binary from tooltool 05:02:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:50 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 0x1175140>, '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 0x1175a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1175ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:02:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:02:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:02:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:02:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:02:50 INFO - Return code: 0 05:02:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:02:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:02:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:02:50 INFO - ENV: RUST_BACKTRACE is now 1 05:02:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:02:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:02:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:02:50 INFO - Using env: {'DISPLAY': ':0', 05:02:50 INFO - 'HOME': '/home/cltbld', 05:02:50 INFO - 'LANG': 'en_US.UTF-8', 05:02:50 INFO - 'LANGUAGE': 'en_US:en', 05:02:50 INFO - 'LOGNAME': 'cltbld', 05:02:50 INFO - 'MAIL': '/var/mail/cltbld', 05:02:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:02:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:50 INFO - 'MOZ_NO_REMOTE': '1', 05:02:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:02:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:50 INFO - 'NO_EM_RESTART': '1', 05:02:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:50 INFO - 'PWD': '/builds/slave/test', 05:02:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:02:50 INFO - 'RUST_BACKTRACE': '1', 05:02:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:02:50 INFO - 'SHELL': '/bin/bash', 05:02:50 INFO - 'SHLVL': '1', 05:02:50 INFO - 'TERM': 'linux', 05:02:50 INFO - 'TMOUT': '86400', 05:02:50 INFO - 'USER': 'cltbld', 05:02:50 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053', 05:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:50 INFO - '_': '/tools/buildbot/bin/python'} 05:02:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:02:50 INFO - mozversion application_buildid: 20170612111647 05:02:50 INFO - mozversion application_changeset: f9605772a0c9098ed1bcaa98089b2c944ed69e9b 05:02:50 INFO - mozversion application_display_name: Nightly 05:02:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:02:50 INFO - mozversion application_name: Firefox 05:02:50 INFO - mozversion application_remotingname: firefox 05:02:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:02:50 INFO - mozversion application_vendor: Mozilla 05:02:50 INFO - mozversion application_version: 55.0a1 05:02:50 INFO - mozversion platform_buildid: 20170612111647 05:02:50 INFO - mozversion platform_changeset: f9605772a0c9098ed1bcaa98089b2c944ed69e9b 05:02:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:02:50 INFO - mozversion platform_version: 55.0a1 05:02:50 INFO - using testdate: 1497268970 05:02:50 INFO - actual date: 1497268970 05:02:50 INFO - starting webserver on 'localhost:38612' 05:02:50 INFO - SUITE-START | Running 2 tests 05:02:50 INFO - TEST-START | dromaeo_css 05:02:50 INFO - operating with platform_type : linux_ 05:02:50 INFO - Initialising browser for dromaeo_css test... 05:02:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38612/getInfo.html -profile /tmp/tmp_X7Opo/profile 05:02:50 INFO - TEST-INFO | started process 4946 (/builds/slave/test/build/application/firefox/firefox http://localhost:38612/getInfo.html) 05:03:26 INFO - TEST-INFO | 4946: killed by SIGTERM 05:03:26 INFO - Browser initialized. 05:03:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:03:26 INFO - TEST-INFO | started process 5174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_X7Opo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:38 INFO - PID 5174 | RSS: Main: 188252160 05:03:38 INFO - PID 5174 | 05:06:40 INFO - PID 5174 | Cycle 1(1): loaded http://localhost:38612/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38612/tests/dromaeo/cssquery-ext.html) 05:06:41 INFO - PID 5174 | RSS: Main: 186318848 05:06:41 INFO - PID 5174 | 05:09:43 INFO - PID 5174 | Cycle 1(1): loaded http://localhost:38612/tests/dromaeo/cssquery-ext.html (next: http://localhost:38612/tests/dromaeo/cssquery-jquery.html) 05:09:44 INFO - PID 5174 | RSS: Main: 186916864 05:09:44 INFO - PID 5174 | 05:12:45 INFO - PID 5174 | Cycle 1(1): loaded http://localhost:38612/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38612/tests/dromaeo/cssquery-mootools.html) 05:12:46 INFO - PID 5174 | RSS: Main: 190726144 05:12:46 INFO - PID 5174 | 05:15:48 INFO - PID 5174 | Cycle 1(1): loaded http://localhost:38612/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38612/tests/dromaeo/cssquery-prototype.html) 05:15:49 INFO - PID 5174 | RSS: Main: 187400192 05:15:49 INFO - PID 5174 | 05:18:51 INFO - PID 5174 | Cycle 1(1): loaded http://localhost:38612/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38612/tests/dromaeo/cssquery-yui.html) 05:18:52 INFO - PID 5174 | RSS: Main: 190595072 05:18:52 INFO - PID 5174 | 05:21:54 INFO - PID 5174 | Cycle 1(1): loaded http://localhost:38612/tests/dromaeo/cssquery-yui.html (next: http://localhost:38612/tests/dromaeo/cssquery-dojo.html) 05:21:54 INFO - PID 5174 | RSS: Main: 189509632 05:21:54 INFO - PID 5174 | 05:21:54 INFO - PID 5174 | __start_tp_report 05:21:54 INFO - PID 5174 | _x_x_mozilla_page_load 05:21:54 INFO - PID 5174 | _x_x_mozilla_page_load_details 05:21:54 INFO - PID 5174 | |i|pagename|runs| 05:21:54 INFO - PID 5174 | |0;dojo.html;3014;3077.830719310437;3079.7382222511087;3095.102420298114;3116.875324986999;5859.17971483992;5937.821865344041;5952.136940143677;6000.129981152731;6000.609960352574;5923.703814809264;5937.109433584965;5943.4056594340545;5950.345461999176;5975.133605627181;5527.640703354289;5551.528120109785;5625.38120806711;5626.902753962979;5672.347680016789;5628.577856660767;5640.774369025234;5651.9152212716845;5653.604247702662;5654.971725141369;5519.586031047687;5523.337199536081;5562.499375056264;5617.8033768818095;5637.943620563783;5396.541293990015;5458.754356053987;5476.863078423032;5528.9723551382385;5536.363318218376;5475.698836563987;5499.230107784913;5512.669239845582;5516.117421212587;5518.2826232589905;5916.349201587822;5926.1110833374905;5938.079597662369;5943.04911214208;5962.940370596282;6429.742810287583;6438.549301548894;6439.484841212692;6442.967785161091;6448.6775661217225;6192.411720886508;6211.751529938797;6291.811245662638;6315.3684631536935;6327.8418039548915;5969.731362088716;5972.880542389128;6005.879882402328;6010.188624535632;6020.187274717857;6514.185726784152;6593.3736295051895;6604.405603495612;6604.405603495708;6610.4050635443045;6276.027215781562;6279.497640188774;6283.214598175228;6286.9056964145575;6292.402221788922;6151.415615516519;6249.281332646713;6327.873442531123;6369.554131210771;6411;6352.7141278642575;6386.808395748135;6391.520635952322;6413.775517856852;6414.166158399378;6366.427021568081;6408.871822563523;6427.550071495044;6432.967835160888;6441.420272175526;5260.28986086881;5264.973675131677;5269.367675878842;5270.183121616155;5301.019311427398;4411.713238639478;4490.3040028795585;4504.369388285642;4517.638588912879;4520.073384956077;5549.5837812164245;5573.804916827891;5603;5608.242887210256;5635.605507614428;6366.395192456709;6423.710933008026;6434.067060276234;6471.708773105222;6485.935140648628;5621;5622.971885140548;5630.662160270315;5650.971745141248;5668.093105103164;5722.2561067061015;5726.9713651431475;5734.254546908875;5735.2257445245195;5737.3975732548315;6078.7872424466705;6200.0699895016105;6213.161223234896;6222.688865556704;6230.345813689497;6334.113224148531;6341.873162536631;6414.807555773335;6480.319566445455;6485.8702825944165;6129.816105516842;6217;6228.252609686867;6235.501159907287;6248.593841400295;6294.433500984934;6330.335314791881;6332.620042797447;6336.461400780985;6353.269374022047;6439.420452159328;6483.7730679425995;6489.318621544669;6500.5449618526245;6509.804705858832;6117.082437634391;6196.349383314687;6196.659183744938;6260.373962603703;6284;6208.844778880564;6218;6222.097795819672;6231.844203894939;6233.314335423191;6130.049842274455;6175.2589689237575;6177.752889884534;6185.505159587132;6191.783287584913;6281.214848143982;6281.71732272058;6286.65423401699;6303.779367722108;6303.873922521432;5983.970080149571;6043.939560604338;6076.3012253591405;6096.512279017757;6097.32929377777 05:21:54 INFO - PID 5174 | |1;ext.html;626.6866566716642;670.5909395268885;677.4343423241593;690.0684076496733;695.5513693667584;25882.87058564707;26224.868875655644;26578.33554161147;26591.4681706366;34034.14914627135;36506.452403213974;36703.81648091762;36860.81569592148;37038.814805926;37215.81392093043;7041.577505349683;7201.963990180068;7207.89188162178;7216.422686185093;7218.386437152848;6977.616231107287;7041.8591628167405;7091.929080709178;7093.361597456228;7115.324044215791;6949.54827936185;7119.928800712004;7180.246074162216;7185.353318201361;7189.17324507683;7142.500024998252;7147.178074521418;7197.676104575306;7225.458090643197;7227.927720722804;7002.929970700278;7116.964415177943;7125.7505987290715;7126.501144919857;7137.393321567673;34236.486452703226;34554.136146596284;34571.13572160716;34588;34775.652243477496;3459.5329630499814;3466.6533346665383;3470.6529347065093;3483.7387195960405;3495.5106285120105;26504.204873853814;26658.600120998202;26691.46617067667;26703.065392711163;26716.465670686477;3493.3362661094566;3624.257027309395;3653.6163702811086;3663.010987033486;3716.8141592920515;142269;145017.99999999895;168533;169112.15443922702;170050;34441.65558344385;34494.96515104551;39873.60758354508;40117.398239026435;40178;43402.56597433985;43444.782776085915;43512;43512.56487435148;43586;14543.78184327236;14647.853521464862;14687.118772873662;14689.559313220621;14716.264186790617;12124.333161676017;12185.695357615954;12221.144519883523;12222.694432639255;12223.75552488963;13252.403641836141;13254.602361929157;13343.799843002364;13372.33138343079;13418.329083545783;5359.035373632705;5492.780288788404;5500.312460942382;5563.499285064283;5575.135853942646;938.784079661668;946.8627049077983;960.4333443268365;990.8018396320765;1002.1110207259223;20238.291659791837;20867;21142;21358.572828543653;21535.13859445636;1052.2003277508995;1054.7943151085617;1059.989400105989;1089.7330154112294;1090.4057288777635;10867.83698244527;11141.777164456827;11205.831912521318;11268.09855211581;11557.30656160633;197935;199346;200929;200950;201393;45584.77207613941;46120;46376.768116159205;46418.767906160254;46472.07055858864;1382;1394.6443656867434;1414.4342263094845;1439.9712005759827;1446.146773403697;23146.88426557924;23314.184003559792;23422.531549368578;23658.88170559136;23802.880985594962;31002;31109.37781244317;31335.21661958469;31347.68652313448;31352.21619459532;143908.28045859703;144385;145240.27379863034;145256;145281;30109.397812043197;30714;30807;30828.22929426782;30936.381272374878;36356;36843.81578092092;38072;38154.80922595369;38301.61698383092;27632.309192270353;27934;28638.42723145567;29148.417031659672;29154.416911662072;28777.136685899455;29223.892806631357;29681.85159074191;29684.851575741985;30041;31332.37335253328;32491.35017299688;33099.66900330966;33127.17182070467;33160.668393315755;26578.601320979815;27707.445851082462;27900.86049569739;28142.2964425891;28876.566851497664;20939.267125650527;22762.65856012194;22834.54330913339;23021.309360719206;23330.300090997298 05:21:54 INFO - PID 5174 | |2;jquery.html;490.7497176440017;493.63471031436745;498.7107477662956;505.90134923689897;520.5523250004995;14018;19320.613587728236;20195.19219231229;20196.495087622818;20233.089510972004;15889.602759931007;16592.17039148041;16636.168191590434;16663.083530405824;22145.33563993079;5871.882562348761;5992.730327135289;6027.457528822405;6057.697115144248;6081.665508397036;5916.733746981375;5957.672328021957;5995.550333724967;6002.519798416116;6030.246219222598;5943.791967281146;5959.374265702104;5984.192134061911;6006.8798624027495;6012.669303188323;5287.339082614692;5703.458171473703;5819.952408566456;5949.821505354825;5967.791127310545;5260.631755777097;5312.415634280226;5327.547158491494;5330.813421530228;5338.225957236179;23660.64509032366;23905.760942390527;23928.40178995539;24040.51918961611;24048.759512404828;1873.4754268804757;1894.0340426382506;1900.1924182222501;1903.6383087213385;1903.8762480438727;15561.922190389088;16062.196890155563;16294.75557866621;16366.099864507447;16838.915805421017;2215.922442714513;2245.5621153875;2248;2254.120892851789;2260.4122928038664;96921.51539242259;99685;99702;108231.45884270607;112557;12483.12618116723;12618.179818311964;12622.30577318238;12929.741405172032;13185.406656700472;19065.237390504502;19070.04649767506;19182.712259316122;19231.03844807754;19242.807571924383;8439.831203375898;8723.52020638871;8771.736847894574;8938.614514750225;9417.71746847582;7823.2567906048835;7861.095973962953;7877.645505952246;8001.919980800118;8006.319462845723;8080.757577272691;8247.298979586682;8276.8344633107;8366;8388.790280243044;2339.3800642829665;2365.9763402365757;2366.124533922425;2400.819938504619;2450.191436825843;911.968081117171;926.1011143087542;936.283742936654;972.4019727867311;976.9364991275544;17369.913150434168;17755.644887102186;18176.636467270582;18217.635647287247;18580.606454515964;923.3582660051334;941.6798288581915;968.7239136845965;984.7095106943469;989.2531138990016;9803.166730827817;9873.223576920056;10042.899571004342;10195.235357348229;10287.897121028695;378544;386370;403147;406148;408416;96387;96849;101332;101463;101786.4910675442;1032.4218437674926;1076.1713480619878;1078.7680648660419;1165.4813607944384;1219.8536175658978;15628.531144065697;17944.820551794313;18213.271469141087;18885.150168242188;19003.144858481126;44906.10187796291;48419;48679;49581.25628115509;50171.24743128783;62090;62189;62206.0669089955;62620;62985.68507157435;10120;10950.06924411434;11064.612738554111;11088.279261847954;11110.944445277722;16487.917560412123;16778.58053548671;16824.327026919276;17026.233819477904;17154.39959601408;13675.384607692877;14111.788323175366;14118.929405353318;14311.642208944859;14367.28163591837;12037.879621203676;12297.938510307391;12309.44607492647;12541.498340066295;12797.040221983574;14450.638734031312;14471;14504.85495145035;14531.709365812836;14532.128072315694;10267.178625709776;10756.892431075588;10887.074598659203;10919.344839309666;10927.180461465263;14396.856031439971;14405.567832965027;14458.277086145861;14508.34712437964;14521.201333926736 05:21:54 INFO - PID 5174 | |3;mootools.html;1300.1224173682763;1346.898982576307;1348.352790660483;1350.9729805403892;1356.7964805279207;11751.529938802449;12005.099617528676;12340;12362.949149322318;12373.13388062836;12077.335746533938;12302.446389912453;12302.81545776814;12305.200161989487;12310.076744244172;2483.0936708101503;2547.6688030556;2548.745125487455;2551.119863647039;2553.3616595851036;2418.2745176447083;2452.0314475782056;2456.9385765355833;2457.8893949772214;2457.913973010945;2389.0921449849034;2413.8793060347;2444.1934161726676;2445.58425067738;2449;2346.5776160291057;2361.031976889484;2383.332666853284;2383.3922349800864;2388.10446082719;2348.8003519700846;2353.8116950643907;2357.622780355152;2383.285014495644;2388.988055059731;11874.465649045813;11942.104342174373;11998.400079996052;12006.819897701542;12022.338771367571;6740.8314792130095;7003.299670033007;7007.264237255065;7018.40343570792;7023.297670232936;3986.4219688145345;4158.189153115144;4210.347396153601;4224.345226489899;4233.809478573472;1408.3169662713576;1467.7578199597053;1493.4996776080027;1493.9701205975819;1494.0438119603355;16587.336506539723;17414.65170696579;18312.725309120375;18368.816311836843;18371.357002504847;5355.973220133875;5794.246747922743;6006.279246490361;6009.369016253318;6020.488258498077;13195.274259915797;13209;13210.669733256746;13211.867881321064;13237.07340486176;6845.760398386033;6852.109225800614;6916.515843890879;6919.8962015569805;6920.342567456084;6308.369163083747;6434;6477.935220647733;6481.092647029325;6565.146530950946;4279.443672322578;4469.08383781324;4490.528494508029;4492.124035813051;4526.049529598756;1321.847987481452;1359.4766015084265;1365.3105181883086;1368.5825823123844;1386.8197134372467;829.8008477965245;832.6586099699215;838.2916435611899;848.6138806842872;866.5667166416791;6239.157713708682;6256.937430625727;6316.147320111726;6450.903236451457;6603.108580341688;665.6072916978909;691.5891581174347;699.912510936133;707.0348973651032;710.6091649592703;3879.689624830007;4020.638142567183;4259.020425302136;4345.130973805251;4404.801783919731;15041.548753537412;15744.842551574338;15761.921190393974;15812.367505299659;15819.920900395655;15376.308066137051;15432.15123168214;15450.613734656723;15742.370305187664;16076.43732469358;9479.146876781122;9605.615775369046;9613;9639.951800241095;9674.75813104678;6413.679316034087;6628.635425051669;6794.8641027180165;7013.789586312419;7065.470089743187;13456.932715336361;13915.72168556603;14051.648708782363;14311.713765724835;14448.422063117358;13213.471461141447;14669.48656797007;14860.851391485947;14973;15098.094114353175;9427;9921.603135874484;10097.192224621866;10196.541155648161;10390.168786497214;11003.22977391575;11066.557337706401;11108.833367499332;11199.440027998731;11282.153838461983;8838.955805220932;9234.861477077715;9273.582688778886;9546.331756777237;9606.855897161407;8934.151255630704;9117.22503587176;9155.77110572241;9177.449353038572;9219.216366608913;8048.83902321962;8092.4335296531035;8116.918830811853;8150.470219435718;8196.54918979462;5523.033469142964;5686.346070201815;5694.886102277848;5937.792177273947;5955.047192449188;5937.881242375042;5990.940090599038;6067.817965461043;6149.538784591263;6158.538109641705 05:21:54 INFO - PID 5174 | |4;prototype.html;414.19025804552103;423.8580075674649;438.4804007251406;446.48654047844985;446.99106017879666;6212.130301757752;6263.561550691454;6289.842753931154;6292.937070629292;6302.653354065525;5879.353271140171;6012.488938440238;6065.8180254592435;6069.78755743549;6075.422834830684;4818.373611430527;4823.638227132961;4851.684640498365;4853.927191092136;4867;4805.447373552051;4850.757462126897;4850.878728031792;4867.123917694814;4870.732109733964;4618.792154353062;4815.422149342084;4819.253015782542;4830.695712157715;4839.637027222955;4747.12178247022;4756.43037797526;4771.540633041052;4771.926316578777;4818.229083346683;4260.297050986584;4277.144571085795;4277.721948073397;4281.464816897887;4290.3135498320435;5893.734781934823;5925.259342582177;5929.9703501482645;5936.9406305937255;5948.851278718067;5488.484073506141;5497.285352904097;5497.945020549783;5525.309336332958;5530.806421775219;6425.518086143558;6449.516286278548;6449.96775016122;6463.93536064638;6472.417482426557;4636.09596128755;4672.742999135046;4676.485586585472;4676.953230467686;4683.555062269079;6757.560758550679;6782.76260330891;6809.863802723968;6832.385085342343;6882.8967565486555;4765.11845308619;4771.379720636295;4779.330893674888;4782.736949467812;4796.832110876172;4764.190087685102;4833.10587541306;4833.275008748716;4842.104210720958;4872;5537.335519737658;5538.196961440569;5538.335399752055;5545.1682247663175;5550;6495.415412612793;6518.771842985473;6521.5108866834225;6524.314946930599;6559.836004099936;1551.5888289603265;1675.2796297592151;1682.7812384389952;1692.1031853117868;1697.3974239145173;1143.3711458697683;1159.4260840883649;1159.750653609478;1159.8840115988503;1160.4487868262509;5689.459501347365;5702.6293290935955;5704.686242256633;5705.885882282331;5709.172170035322;6556.27880933097;6565.507586930904;6566.376194261537;6574.901376479356;6593.8351541210895;5666;5680.857978550486;5683.60214784961;5685.943140568541;5691.430856914359;3415.7608967372043;3491.877784277538;3525.8540974183493;3556.8577256909953;3572.3034008368118;6373.840653983688;6398.168238129107;6417.614943103429;6419.711112999927;6439.742410303629;6775.695093720795;6794.864102717918;6818.2159051708695;6818.590884546943;6832.726690932406;6390.968045159838;6416.7754128605275;6433.970564709624;6441.935580644321;6444.484441244689;6593.406593406425;6600.636964966973;6655.201375834931;6694.364035416627;6711.932880671131;6612.206535215805;6614.875471169817;6623.138991931018;6630.83422914431;6633.767818126343;6358.109864619049;6372.235331760218;6379.853095487784;6392.232932048184;6399.232092148972;4719.74041427711;4756.643251756063;4759.976200118977;4762.785674644719;4763.737994410202;6635.834104147435;6659.036728655702;6672.83317917056;6677.8280316849105;6689.732410703712;6223.688815559113;6288.80512702585;6431.678416079271;6476.935230647821;6478.704259148283;6018.608790428783;6167.784127555514;6342.39747224013;6413.807585772434;6472.15861937945;6310.5267104968225;6327.588706734047;6338.239411270677;6359.395857393541;6376.055303132589;6463.547551671526;6482.384173503509;6510.47916166715;6513.250976137805;6514.57655252407;6240.003198976284;6278.277998030285;6308.634262151693;6311.873762524816;6313.273973493107 05:21:54 INFO - PID 5174 | |5;yui.html;791.4697152907552;826.768504818651;829.5603330234975;840.210202409735;840.5545061117606;16604.252808623613;17052.744208836848;17134.657306853856;17259.74110388345;17344.653106937854;17452.30190792367;18596.721049184274;18686.345977890778;18819.43541693748;18823.341183058597;941.6233506597382;964.744342749172;967.7387105481516;967.8209531236744;967.8306296398138;969.3553786731815;969.8448248280276;969.9175570076552;972.0085512776964;992.2012779712329;1016.872890888639;1021.7956408718248;1022.8005538919914;1024.7438140464883;1027.6968294353146;953.7853982853871;979.1628157924943;1015.8984101589856;1017.6183931025828;1028.603987464824;738.3059923671732;738.65283316841;739.3013602145974;740.5778706137504;742.0427648333643;16620.168991550374;16631.6673666526;16702.58243543921;16929.49211523644;16955.745663815054;18084.186211620377;18659;18707.34524291643;18770.155343009596;18875.339363122224;14873.47942822007;14965.925170374187;15033.624159395993;15092.094474331576;15119.773203401957;3434.8282585870857;3459.08334291413;3459.6540345965454;3465.2376477175235;3465.8267086645565;75350;76835;80006.19993800046;80580.19419805786;80878.59560702159;15002;15194.088354698753;15307.846921530865;15434.614134646723;15458.768118478232;26413.07554235631;26872.462550748874;26997.86501067482;27109.86445067762;27152.728472715415;8717.607707653171;8734.912650873537;8738.082501337396;8752.737417877473;8795.824083518422;3985.3822657488136;4036.253293140778;4040.4949381327333;4097.508299004138;4109.97945010273;4222.936655950163;4393.121375724804;4486.439195100613;4496.820127194876;4577.313402989512;902.6479672927433;921.944683319003;925.3245131054233;928.1368327455397;936.2556767369957;596.6705781737892;638.8051644248455;660.7489154121403;680.5168330485411;693.2582137113241;10031.891568666591;10516.316439431412;10916.945415272872;10921.453927303603;10965.122790176927;638.5689659479832;648.7113234610647;649.3928177154376;670.9329067093349;672.3276723276723;4511.639068874482;4567.38340324052;4696.882577935579;4859.16899720337;4870.245112007645;84455;89673.55163224142;89864;91920;93307;76009;76153;77879;78713.60643196861;80697.59651201824;65351.673241633485;68776.31223687799;69967.3003269971;70435;70567.64716176386;9639.9036009639;9672.645829584004;9890.208783297463;10068.772572854563;10100.545475453475;29926.850365748032;30157.69842301549;30586.541201882435;30755.38489230158;31542.526862096627;40330.59669403268;40878.1824363517;41300.58699412968;53457.198142027126;56331.71834140803;16545.25546350393;16625.3349866004;17261.482155535356;17482.650346993243;17516.38692645751;17877.73183402224;18103.81896181074;18731.438056858315;18926.242950281834;19084.236630534622;14771.926140369229;14992.100473971597;15335.846641533442;15410.229488525305;15900.92049539745;16662.75005874937;17321.307147714455;17504.562385940455;17703.55741106431;17907.10464476745;14970.550883473514;15016.399344026553;15039.849601504282;15086.094834309977;15522.146281954601;11893.702657433634;12060.51757929708;12137.453814578188;12206.511739530319;12356.320402377956;13492.392842321922;13639.79540306916;13797.79303310431;14618.85381146175;14647.707045859237 05:21:54 INFO - PID 5174 | __end_tp_report 05:21:54 INFO - PID 5174 | __start_cc_report 05:21:54 INFO - PID 5174 | _x_x_mozilla_cycle_collect,392 05:21:54 INFO - PID 5174 | __end_cc_report 05:21:54 INFO - PID 5174 | __startTimestamp1497270114434__endTimestamp 05:21:54 INFO - PID 5174 | 05:21:54 INFO - PID 5174 | ------- Summary: start ------- 05:21:54 INFO - PID 5174 | Number of tests: 6 05:21:54 INFO - PID 5174 | 05:21:54 INFO - PID 5174 | [#0] dojo.html Cycles:165 Average:5913.33 Median:6129.82 stddev:667.63 (10.9%) stddev-sans-first:629.75 05:21:54 INFO - PID 5174 | Values: 3014.0 3077.8 3079.7 3095.1 3116.9 5859.2 5937.8 5952.1 6000.1 6000.6 5923.7 5937.1 5943.4 5950.3 5975.1 5527.6 5551.5 5625.4 5626.9 5672.3 5628.6 5640.8 5651.9 5653.6 5655.0 5519.6 5523.3 5562.5 5617.8 5637.9 5396.5 5458.8 5476.9 5529.0 5536.4 5475.7 5499.2 5512.7 5516.1 5518.3 5916.3 5926.1 5938.1 5943.0 5962.9 6429.7 6438.5 6439.5 6443.0 6448.7 6192.4 6211.8 6291.8 6315.4 6327.8 5969.7 5972.9 6005.9 6010.2 6020.2 6514.2 6593.4 6604.4 6604.4 6610.4 6276.0 6279.5 6283.2 6286.9 6292.4 6151.4 6249.3 6327.9 6369.6 6411.0 6352.7 6386.8 6391.5 6413.8 6414.2 6366.4 6408.9 6427.6 6433.0 6441.4 5260.3 5265.0 5269.4 5270.2 5301.0 4411.7 4490.3 4504.4 4517.6 4520.1 5549.6 5573.8 5603.0 5608.2 5635.6 6366.4 6423.7 6434.1 6471.7 6485.9 5621.0 5623.0 5630.7 5651.0 5668.1 5722.3 5727.0 5734.3 5735.2 5737.4 6078.8 6200.1 6213.2 6222.7 6230.3 6334.1 6341.9 6414.8 6480.3 6485.9 6129.8 6217.0 6228.3 6235.5 6248.6 6294.4 6330.3 6332.6 6336.5 6353.3 6439.4 6483.8 6489.3 6500.5 6509.8 6117.1 6196.3 6196.7 6260.4 6284.0 6208.8 6218.0 6222.1 6231.8 6233.3 6130.0 6175.3 6177.8 6185.5 6191.8 6281.2 6281.7 6286.7 6303.8 6303.9 5984.0 6043.9 6076.3 6096.5 6097.3 05:21:54 INFO - PID 5174 | 05:21:54 INFO - PID 5174 | [#1] ext.html Cycles:180 Average:31836.79 Median:31055.69 stddev:43842.78 (141.2%) stddev-sans-first:43903.14 05:21:54 INFO - PID 5174 | Values: 626.7 670.6 677.4 690.1 695.6 25882.9 26224.9 26578.3 26591.5 34034.1 36506.5 36703.8 36860.8 37038.8 37215.8 7041.6 7202.0 7207.9 7216.4 7218.4 6977.6 7041.9 7091.9 7093.4 7115.3 6949.5 7119.9 7180.2 7185.4 7189.2 7142.5 7147.2 7197.7 7225.5 7227.9 7002.9 7117.0 7125.8 7126.5 7137.4 34236.5 34554.1 34571.1 34588.0 34775.7 3459.5 3466.7 3470.7 3483.7 3495.5 26504.2 26658.6 26691.5 26703.1 26716.5 3493.3 3624.3 3653.6 3663.0 3716.8 142269.0 145018.0 168533.0 169112.2 170050.0 34441.7 34495.0 39873.6 40117.4 40178.0 43402.6 43444.8 43512.0 43512.6 43586.0 14543.8 14647.9 14687.1 14689.6 14716.3 12124.3 12185.7 12221.1 12222.7 12223.8 13252.4 13254.6 13343.8 13372.3 13418.3 5359.0 5492.8 5500.3 5563.5 5575.1 938.8 946.9 960.4 990.8 1002.1 20238.3 20867.0 21142.0 21358.6 21535.1 1052.2 1054.8 1060.0 1089.7 1090.4 10867.8 11141.8 11205.8 11268.1 11557.3 197935.0 199346.0 200929.0 200950.0 201393.0 45584.8 46120.0 46376.8 46418.8 46472.1 1382.0 1394.6 1414.4 1440.0 1446.1 23146.9 23314.2 23422.5 23658.9 23802.9 31002.0 31109.4 31335.2 31347.7 31352.2 143908.3 144385.0 145240.3 145256.0 145281.0 30109.4 30714.0 30807.0 30828.2 30936.4 36356.0 36843.8 38072.0 38154.8 38301.6 27632.3 27934.0 28638.4 29148.4 29154.4 28777.1 29223.9 29681.9 29684.9 30041.0 31332.4 32491.4 33099.7 33127.2 33160.7 26578.6 27707.4 27900.9 28142.3 28876.6 20939.3 22762.7 22834.5 23021.3 23330.3 05:21:54 INFO - PID 5174 | 05:21:54 INFO - PID 5174 | [#2] jquery.html Cycles:180 Average:28410.56 Median:2251.06 stddev:66785.05 (2966.8%) stddev-sans-first:66939.50 05:21:54 INFO - PID 5174 | Values: 490.7 493.6 498.7 505.9 520.6 14018.0 19320.6 20195.2 20196.5 20233.1 15889.6 16592.2 16636.2 16663.1 22145.3 5871.9 5992.7 6027.5 6057.7 6081.7 5916.7 5957.7 5995.6 6002.5 6030.2 5943.8 5959.4 5984.2 6006.9 6012.7 5287.3 5703.5 5820.0 5949.8 5967.8 5260.6 5312.4 5327.5 5330.8 5338.2 23660.6 23905.8 23928.4 24040.5 24048.8 1873.5 1894.0 1900.2 1903.6 1903.9 15561.9 16062.2 16294.8 16366.1 16838.9 2215.9 2245.6 2248.0 2254.1 2260.4 96921.5 99685.0 99702.0 108231.5 112557.0 12483.1 12618.2 12622.3 12929.7 13185.4 19065.2 19070.0 19182.7 19231.0 19242.8 8439.8 8723.5 8771.7 8938.6 9417.7 7823.3 7861.1 7877.6 8001.9 8006.3 8080.8 8247.3 8276.8 8366.0 8388.8 2339.4 2366.0 2366.1 2400.8 2450.2 912.0 926.1 936.3 972.4 976.9 17369.9 17755.6 18176.6 18217.6 18580.6 923.4 941.7 968.7 984.7 989.3 9803.2 9873.2 10042.9 10195.2 10287.9 378544.0 386370.0 403147.0 406148.0 408416.0 96387.0 96849.0 101332.0 101463.0 101786.5 1032.4 1076.2 1078.8 1165.5 1219.9 15628.5 17944.8 18213.3 18885.2 19003.1 44906.1 48419.0 48679.0 49581.3 50171.2 62090.0 62189.0 62206.1 62620.0 62985.7 10120.0 10950.1 11064.6 11088.3 11110.9 16487.9 16778.6 16824.3 17026.2 17154.4 13675.4 14111.8 14118.9 14311.6 14367.3 12037.9 12297.9 12309.4 12541.5 12797.0 14450.6 14471.0 14504.9 14531.7 14532.1 10267.2 10756.9 10887.1 10919.3 10927.2 14396.9 14405.6 14458.3 14508.3 14521.2 05:21:54 INFO - PID 5174 | 05:21:54 INFO - PID 5174 | [#3] mootools.html Cycles:180 Average:7398.04 Median:2549.93 stddev:4825.34 (189.2%) stddev-sans-first:4817.12 05:21:54 INFO - PID 5174 | Values: 1300.1 1346.9 1348.4 1351.0 1356.8 11751.5 12005.1 12340.0 12362.9 12373.1 12077.3 12302.4 12302.8 12305.2 12310.1 2483.1 2547.7 2548.7 2551.1 2553.4 2418.3 2452.0 2456.9 2457.9 2457.9 2389.1 2413.9 2444.2 2445.6 2449.0 2346.6 2361.0 2383.3 2383.4 2388.1 2348.8 2353.8 2357.6 2383.3 2389.0 11874.5 11942.1 11998.4 12006.8 12022.3 6740.8 7003.3 7007.3 7018.4 7023.3 3986.4 4158.2 4210.3 4224.3 4233.8 1408.3 1467.8 1493.5 1494.0 1494.0 16587.3 17414.7 18312.7 18368.8 18371.4 5356.0 5794.2 6006.3 6009.4 6020.5 13195.3 13209.0 13210.7 13211.9 13237.1 6845.8 6852.1 6916.5 6919.9 6920.3 6308.4 6434.0 6477.9 6481.1 6565.1 4279.4 4469.1 4490.5 4492.1 4526.0 1321.8 1359.5 1365.3 1368.6 1386.8 829.8 832.7 838.3 848.6 866.6 6239.2 6256.9 6316.1 6450.9 6603.1 665.6 691.6 699.9 707.0 710.6 3879.7 4020.6 4259.0 4345.1 4404.8 15041.5 15744.8 15761.9 15812.4 15819.9 15376.3 15432.2 15450.6 15742.4 16076.4 9479.1 9605.6 9613.0 9640.0 9674.8 6413.7 6628.6 6794.9 7013.8 7065.5 13456.9 13915.7 14051.6 14311.7 14448.4 13213.5 14669.5 14860.9 14973.0 15098.1 9427.0 9921.6 10097.2 10196.5 10390.2 11003.2 11066.6 11108.8 11199.4 11282.2 8839.0 9234.9 9273.6 9546.3 9606.9 8934.2 9117.2 9155.8 9177.4 9219.2 8048.8 8092.4 8116.9 8150.5 8196.5 5523.0 5686.3 5694.9 5937.8 5955.0 5937.9 5990.9 6067.8 6149.5 6158.5 05:21:54 INFO - PID 5174 | 05:21:54 INFO - PID 5174 | [#4] prototype.html Cycles:180 Average:5391.43 Median:5980.67 stddev:1552.34 (26.0%) stddev-sans-first:1511.08 05:21:54 INFO - PID 5174 | Values: 414.2 423.9 438.5 446.5 447.0 6212.1 6263.6 6289.8 6292.9 6302.7 5879.4 6012.5 6065.8 6069.8 6075.4 4818.4 4823.6 4851.7 4853.9 4867.0 4805.4 4850.8 4850.9 4867.1 4870.7 4618.8 4815.4 4819.3 4830.7 4839.6 4747.1 4756.4 4771.5 4771.9 4818.2 4260.3 4277.1 4277.7 4281.5 4290.3 5893.7 5925.3 5930.0 5936.9 5948.9 5488.5 5497.3 5497.9 5525.3 5530.8 6425.5 6449.5 6450.0 6463.9 6472.4 4636.1 4672.7 4676.5 4677.0 4683.6 6757.6 6782.8 6809.9 6832.4 6882.9 4765.1 4771.4 4779.3 4782.7 4796.8 4764.2 4833.1 4833.3 4842.1 4872.0 5537.3 5538.2 5538.3 5545.2 5550.0 6495.4 6518.8 6521.5 6524.3 6559.8 1551.6 1675.3 1682.8 1692.1 1697.4 1143.4 1159.4 1159.8 1159.9 1160.4 5689.5 5702.6 5704.7 5705.9 5709.2 6556.3 6565.5 6566.4 6574.9 6593.8 5666.0 5680.9 5683.6 5685.9 5691.4 3415.8 3491.9 3525.9 3556.9 3572.3 6373.8 6398.2 6417.6 6419.7 6439.7 6775.7 6794.9 6818.2 6818.6 6832.7 6391.0 6416.8 6434.0 6441.9 6444.5 6593.4 6600.6 6655.2 6694.4 6711.9 6612.2 6614.9 6623.1 6630.8 6633.8 6358.1 6372.2 6379.9 6392.2 6399.2 4719.7 4756.6 4760.0 4762.8 4763.7 6635.8 6659.0 6672.8 6677.8 6689.7 6223.7 6288.8 6431.7 6476.9 6478.7 6018.6 6167.8 6342.4 6413.8 6472.2 6310.5 6327.6 6338.2 6359.4 6376.1 6463.5 6482.4 6510.5 6513.3 6514.6 6240.0 6278.3 6308.6 6311.9 6313.3 05:21:54 INFO - PID 5174 | 05:21:54 INFO - PID 5174 | [#5] yui.html Cycles:180 Average:19000.33 Median:3446.96 stddev:23532.36 (682.7%) stddev-sans-first:23558.65 05:21:54 INFO - PID 5174 | Values: 791.5 826.8 829.6 840.2 840.6 16604.3 17052.7 17134.7 17259.7 17344.7 17452.3 18596.7 18686.3 18819.4 18823.3 941.6 964.7 967.7 967.8 967.8 969.4 969.8 969.9 972.0 992.2 1016.9 1021.8 1022.8 1024.7 1027.7 953.8 979.2 1015.9 1017.6 1028.6 738.3 738.7 739.3 740.6 742.0 16620.2 16631.7 16702.6 16929.5 16955.7 18084.2 18659.0 18707.3 18770.2 18875.3 14873.5 14965.9 15033.6 15092.1 15119.8 3434.8 3459.1 3459.7 3465.2 3465.8 75350.0 76835.0 80006.2 80580.2 80878.6 15002.0 15194.1 15307.8 15434.6 15458.8 26413.1 26872.5 26997.9 27109.9 27152.7 8717.6 8734.9 8738.1 8752.7 8795.8 3985.4 4036.3 4040.5 4097.5 4110.0 4222.9 4393.1 4486.4 4496.8 4577.3 902.6 921.9 925.3 928.1 936.3 596.7 638.8 660.7 680.5 693.3 10031.9 10516.3 10916.9 10921.5 10965.1 638.6 648.7 649.4 670.9 672.3 4511.6 4567.4 4696.9 4859.2 4870.2 84455.0 89673.6 89864.0 91920.0 93307.0 76009.0 76153.0 77879.0 78713.6 80697.6 65351.7 68776.3 69967.3 70435.0 70567.6 9639.9 9672.6 9890.2 10068.8 10100.5 29926.9 30157.7 30586.5 30755.4 31542.5 40330.6 40878.2 41300.6 53457.2 56331.7 16545.3 16625.3 17261.5 17482.7 17516.4 17877.7 18103.8 18731.4 18926.2 19084.2 14771.9 14992.1 15335.8 15410.2 15900.9 16662.8 17321.3 17504.6 17703.6 17907.1 14970.6 15016.4 15039.8 15086.1 15522.1 11893.7 12060.5 12137.5 12206.5 12356.3 13492.4 13639.8 13797.8 14618.9 14647.7 05:21:54 INFO - PID 5174 | -------- Summary: end -------- 05:21:54 INFO - PID 5174 | 05:21:55 INFO - TEST-INFO | 5174: exit 0 05:21:55 INFO - TEST-OK | dromaeo_css | took 1144546ms 05:21:55 INFO - TEST-START | kraken 05:21:55 INFO - operating with platform_type : linux_ 05:21:55 INFO - Initialising browser for kraken test... 05:21:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38612/getInfo.html -profile /tmp/tmpkuMPky/profile 05:21:55 INFO - TEST-INFO | started process 5602 (/builds/slave/test/build/application/firefox/firefox http://localhost:38612/getInfo.html) 05:22:30 INFO - TEST-INFO | 5602: killed by SIGTERM 05:22:30 INFO - Browser initialized. 05:22:30 INFO - Running cycle 1/1 for kraken test... 05:22:30 INFO - TEST-INFO | started process 5832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkuMPky/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:42 INFO - PID 5832 | RSS: Main: 188493824 05:22:42 INFO - PID 5832 | 05:22:45 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38612/tests/kraken/driver.html?testName=audio-beat-detection) 05:22:46 INFO - PID 5832 | RSS: Main: 191328256 05:22:46 INFO - PID 5832 | 05:22:48 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38612/tests/kraken/driver.html?testName=audio-dft) 05:22:49 INFO - PID 5832 | RSS: Main: 192180224 05:22:49 INFO - PID 5832 | 05:22:52 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38612/tests/kraken/driver.html?testName=audio-fft) 05:22:53 INFO - PID 5832 | RSS: Main: 187138048 05:22:53 INFO - PID 5832 | 05:22:55 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38612/tests/kraken/driver.html?testName=audio-oscillator) 05:22:55 INFO - PID 5832 | RSS: Main: 188555264 05:22:55 INFO - PID 5832 | 05:22:57 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38612/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:22:58 INFO - PID 5832 | RSS: Main: 188608512 05:22:58 INFO - PID 5832 | 05:23:01 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38612/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:02 INFO - PID 5832 | RSS: Main: 189829120 05:23:02 INFO - PID 5832 | 05:23:05 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38612/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:06 INFO - PID 5832 | RSS: Main: 191193088 05:23:06 INFO - PID 5832 | 05:23:09 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38612/tests/kraken/driver.html?testName=json-parse-financial) 05:23:09 INFO - PID 5832 | RSS: Main: 190148608 05:23:09 INFO - PID 5832 | 05:23:11 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38612/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:12 INFO - PID 5832 | RSS: Main: 190033920 05:23:12 INFO - PID 5832 | 05:23:13 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:14 INFO - PID 5832 | RSS: Main: 189841408 05:23:14 INFO - PID 5832 | 05:23:16 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:23:17 INFO - PID 5832 | RSS: Main: 190054400 05:23:17 INFO - PID 5832 | 05:23:20 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:23:20 INFO - PID 5832 | RSS: Main: 189915136 05:23:20 INFO - PID 5832 | 05:23:24 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:23:24 INFO - PID 5832 | RSS: Main: 189861888 05:23:24 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | Cycle 1(1): loaded http://localhost:38612/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38612/tests/kraken/driver.html?testName=ai-astar) 05:23:26 INFO - PID 5832 | RSS: Main: 191365120 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | __start_tp_report 05:23:26 INFO - PID 5832 | _x_x_mozilla_page_load 05:23:26 INFO - PID 5832 | _x_x_mozilla_page_load_details 05:23:26 INFO - PID 5832 | |i|pagename|runs| 05:23:26 INFO - PID 5832 | |0;ai-astar;104;109;111;111;115;110;113;110;110;114 05:23:26 INFO - PID 5832 | |1;audio-beat-detection;160;122;149;159;122;157;146;122;173;123 05:23:26 INFO - PID 5832 | |2;audio-dft;163;168;166;164;167;172;168;166;165;166 05:23:26 INFO - PID 5832 | |3;audio-fft;76;77;77;167;77;74;74;74;100;74 05:23:26 INFO - PID 5832 | |4;audio-oscillator;84;85;136;85;84;83;133;83;87;140 05:23:26 INFO - PID 5832 | |5;imaging-gaussian-blur;114;113;117;113;114;114;114;115;115;114 05:23:26 INFO - PID 5832 | |6;imaging-darkroom;150;150;150;152;153;152;151;150;150;150 05:23:26 INFO - PID 5832 | |7;imaging-desaturate;94;95;95;95;99;95;94;95;94;99 05:23:26 INFO - PID 5832 | |8;json-parse-financial;55;57;53;54;54;55;55;58;56;54 05:23:26 INFO - PID 5832 | |9;json-stringify-tinderbox;58;57;56;57;56;57;57;57;57;56 05:23:26 INFO - PID 5832 | |10;stanford-crypto-aes;81;79;78;83;82;80;88;80;79;81 05:23:26 INFO - PID 5832 | |11;stanford-crypto-ccm;133;135;146;136;137;139;134;134;135;157 05:23:26 INFO - PID 5832 | |12;stanford-crypto-pbkdf2;185;195;198;195;188;192;200;196;200;185 05:23:26 INFO - PID 5832 | |13;stanford-crypto-sha256-iterative;77;75;75;78;75;73;71;73;76;73 05:23:26 INFO - PID 5832 | __end_tp_report 05:23:26 INFO - PID 5832 | __start_cc_report 05:23:26 INFO - PID 5832 | _x_x_mozilla_cycle_collect,1009 05:23:26 INFO - PID 5832 | __end_cc_report 05:23:26 INFO - PID 5832 | __startTimestamp1497270206697__endTimestamp 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | ------- Summary: start ------- 05:23:26 INFO - PID 5832 | Number of tests: 14 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:3.06 (2.8%) stddev-sans-first:2.07 05:23:26 INFO - PID 5832 | Values: 104.0 109.0 111.0 111.0 115.0 110.0 113.0 110.0 110.0 114.0 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:153.00 stddev:19.46 (12.7%) stddev-sans-first:19.68 05:23:26 INFO - PID 5832 | Values: 160.0 122.0 149.0 159.0 122.0 157.0 146.0 122.0 173.0 123.0 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#2] audio-dft Cycles:10 Average:166.50 Median:166.50 stddev:2.51 (1.5%) stddev-sans-first:2.32 05:23:26 INFO - PID 5832 | Values: 163.0 168.0 166.0 164.0 167.0 172.0 168.0 166.0 165.0 166.0 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#3] audio-fft Cycles:10 Average:87.00 Median:75.00 stddev:29.19 (38.9%) stddev-sans-first:30.68 05:23:26 INFO - PID 5832 | Values: 76.0 77.0 77.0 167.0 77.0 74.0 74.0 74.0 100.0 74.0 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#4] audio-oscillator Cycles:10 Average:100.00 Median:84.00 stddev:25.15 (29.9%) stddev-sans-first:26.00 05:23:26 INFO - PID 5832 | Values: 84.0 85.0 136.0 85.0 84.0 83.0 133.0 83.0 87.0 140.0 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 05:23:26 INFO - PID 5832 | Values: 114.0 113.0 117.0 113.0 114.0 114.0 114.0 115.0 115.0 114.0 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:150.50 stddev:1.14 (0.8%) stddev-sans-first:1.17 05:23:26 INFO - PID 5832 | Values: 150.0 150.0 150.0 152.0 153.0 152.0 151.0 150.0 150.0 150.0 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.90 (2.0%) stddev-sans-first:1.94 05:23:26 INFO - PID 5832 | Values: 94.0 95.0 95.0 95.0 99.0 95.0 94.0 95.0 94.0 99.0 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.52 (2.8%) stddev-sans-first:1.62 05:23:26 INFO - PID 5832 | Values: 55.0 57.0 53.0 54.0 54.0 55.0 55.0 58.0 56.0 54.0 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:57.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 05:23:26 INFO - PID 5832 | Values: 58.0 57.0 56.0 57.0 56.0 57.0 57.0 57.0 57.0 56.0 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:81.00 stddev:2.85 (3.5%) stddev-sans-first:3.02 05:23:26 INFO - PID 5832 | Values: 81.0 79.0 78.0 83.0 82.0 80.0 88.0 80.0 79.0 81.0 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:136.50 stddev:7.47 (5.5%) stddev-sans-first:7.64 05:23:26 INFO - PID 5832 | Values: 133.0 135.0 146.0 136.0 137.0 139.0 134.0 134.0 135.0 157.0 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.40 Median:195.50 stddev:5.70 (2.9%) stddev-sans-first:5.17 05:23:26 INFO - PID 5832 | Values: 185.0 195.0 198.0 195.0 188.0 192.0 200.0 196.0 200.0 185.0 05:23:26 INFO - PID 5832 | 05:23:26 INFO - PID 5832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:75.00 stddev:2.12 (2.8%) stddev-sans-first:2.06 05:23:26 INFO - PID 5832 | Values: 77.0 75.0 75.0 78.0 75.0 73.0 71.0 73.0 76.0 73.0 05:23:26 INFO - PID 5832 | -------- Summary: end -------- 05:23:26 INFO - PID 5832 | 05:23:27 INFO - TEST-INFO | 5832: exit 0 05:23:28 INFO - TEST-OK | kraken | took 92578ms 05:23:28 INFO - SUITE-END | took 1237s 05:23:28 INFO - Completed test suite (00:20:37) 05:23:28 INFO - javascript benchmark 05:23:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7630.527490161594, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3014.0, 3077.830719310437, 3079.7382222511087, 3095.102420298114, 3116.875324986999, 5859.17971483992, 5937.821865344041, 5952.136940143677, 6000.129981152731, 6000.609960352574, 5923.703814809264, 5937.109433584965, 5943.4056594340545, 5950.345461999176, 5975.133605627181, 5527.640703354289, 5551.528120109785, 5625.38120806711, 5626.902753962979, 5672.347680016789, 5628.577856660767, 5640.774369025234, 5651.9152212716845, 5653.604247702662, 5654.971725141369, 5519.586031047687, 5523.337199536081, 5562.499375056264, 5617.8033768818095, 5637.943620563783, 5396.541293990015, 5458.754356053987, 5476.863078423032, 5528.9723551382385, 5536.363318218376, 5475.698836563987, 5499.230107784913, 5512.669239845582, 5516.117421212587, 5518.2826232589905, 5916.349201587822, 5926.1110833374905, 5938.079597662369, 5943.04911214208, 5962.940370596282, 6429.742810287583, 6438.549301548894, 6439.484841212692, 6442.967785161091, 6448.6775661217225, 6192.411720886508, 6211.751529938797, 6291.811245662638, 6315.3684631536935, 6327.8418039548915, 5969.731362088716, 5972.880542389128, 6005.879882402328, 6010.188624535632, 6020.187274717857, 6514.185726784152, 6593.3736295051895, 6604.405603495612, 6604.405603495708, 6610.4050635443045, 6276.027215781562, 6279.497640188774, 6283.214598175228, 6286.9056964145575, 6292.402221788922, 6151.415615516519, 6249.281332646713, 6327.873442531123, 6369.554131210771, 6411.0, 6352.7141278642575, 6386.808395748135, 6391.520635952322, 6413.775517856852, 6414.166158399378, 6366.427021568081, 6408.871822563523, 6427.550071495044, 6432.967835160888, 6441.420272175526, 5260.28986086881, 5264.973675131677, 5269.367675878842, 5270.183121616155, 5301.019311427398, 4411.713238639478, 4490.3040028795585, 4504.369388285642, 4517.638588912879, 4520.073384956077, 5549.5837812164245, 5573.804916827891, 5603.0, 5608.242887210256, 5635.605507614428, 6366.395192456709, 6423.710933008026, 6434.067060276234, 6471.708773105222, 6485.935140648628, 5621.0, 5622.971885140548, 5630.662160270315, 5650.971745141248, 5668.093105103164, 5722.2561067061015, 5726.9713651431475, 5734.254546908875, 5735.2257445245195, 5737.3975732548315, 6078.7872424466705, 6200.0699895016105, 6213.161223234896, 6222.688865556704, 6230.345813689497, 6334.113224148531, 6341.873162536631, 6414.807555773335, 6480.319566445455, 6485.8702825944165, 6129.816105516842, 6217.0, 6228.252609686867, 6235.501159907287, 6248.593841400295, 6294.433500984934, 6330.335314791881, 6332.620042797447, 6336.461400780985, 6353.269374022047, 6439.420452159328, 6483.7730679425995, 6489.318621544669, 6500.5449618526245, 6509.804705858832, 6117.082437634391, 6196.349383314687, 6196.659183744938, 6260.373962603703, 6284.0, 6208.844778880564, 6218.0, 6222.097795819672, 6231.844203894939, 6233.314335423191, 6130.049842274455, 6175.2589689237575, 6177.752889884534, 6185.505159587132, 6191.783287584913, 6281.214848143982, 6281.71732272058, 6286.65423401699, 6303.779367722108, 6303.873922521432, 5983.970080149571, 6043.939560604338, 6076.3012253591405, 6096.512279017757, 6097.32929377777], "value": 5864.922933532866, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.6866566716642, 670.5909395268885, 677.4343423241593, 690.0684076496733, 695.5513693667584, 25882.87058564707, 26224.868875655644, 26578.33554161147, 26591.4681706366, 34034.14914627135, 36506.452403213974, 36703.81648091762, 36860.81569592148, 37038.814805926, 37215.81392093043, 7041.577505349683, 7201.963990180068, 7207.89188162178, 7216.422686185093, 7218.386437152848, 6977.616231107287, 7041.8591628167405, 7091.929080709178, 7093.361597456228, 7115.324044215791, 6949.54827936185, 7119.928800712004, 7180.246074162216, 7185.353318201361, 7189.17324507683, 7142.500024998252, 7147.178074521418, 7197.676104575306, 7225.458090643197, 7227.927720722804, 7002.929970700278, 7116.964415177943, 7125.7505987290715, 7126.501144919857, 7137.393321567673, 34236.486452703226, 34554.136146596284, 34571.13572160716, 34588.0, 34775.652243477496, 3459.5329630499814, 3466.6533346665383, 3470.6529347065093, 3483.7387195960405, 3495.5106285120105, 26504.204873853814, 26658.600120998202, 26691.46617067667, 26703.065392711163, 26716.465670686477, 3493.3362661094566, 3624.257027309395, 3653.6163702811086, 3663.010987033486, 3716.8141592920515, 142269.0, 145017.99999999895, 168533.0, 169112.15443922702, 170050.0, 34441.65558344385, 34494.96515104551, 39873.60758354508, 40117.398239026435, 40178.0, 43402.56597433985, 43444.782776085915, 43512.0, 43512.56487435148, 43586.0, 14543.78184327236, 14647.853521464862, 14687.118772873662, 14689.559313220621, 14716.264186790617, 12124.333161676017, 12185.695357615954, 12221.144519883523, 12222.694432639255, 12223.75552488963, 13252.403641836141, 13254.602361929157, 13343.799843002364, 13372.33138343079, 13418.329083545783, 5359.035373632705, 5492.780288788404, 5500.312460942382, 5563.499285064283, 5575.135853942646, 938.784079661668, 946.8627049077983, 960.4333443268365, 990.8018396320765, 1002.1110207259223, 20238.291659791837, 20867.0, 21142.0, 21358.572828543653, 21535.13859445636, 1052.2003277508995, 1054.7943151085617, 1059.989400105989, 1089.7330154112294, 1090.4057288777635, 10867.83698244527, 11141.777164456827, 11205.831912521318, 11268.09855211581, 11557.30656160633, 197935.0, 199346.0, 200929.0, 200950.0, 201393.0, 45584.77207613941, 46120.0, 46376.768116159205, 46418.767906160254, 46472.07055858864, 1382.0, 1394.6443656867434, 1414.4342263094845, 1439.9712005759827, 1446.146773403697, 23146.88426557924, 23314.184003559792, 23422.531549368578, 23658.88170559136, 23802.880985594962, 31002.0, 31109.37781244317, 31335.21661958469, 31347.68652313448, 31352.21619459532, 143908.28045859703, 144385.0, 145240.27379863034, 145256.0, 145281.0, 30109.397812043197, 30714.0, 30807.0, 30828.22929426782, 30936.381272374878, 36356.0, 36843.81578092092, 38072.0, 38154.80922595369, 38301.61698383092, 27632.309192270353, 27934.0, 28638.42723145567, 29148.417031659672, 29154.416911662072, 28777.136685899455, 29223.892806631357, 29681.85159074191, 29684.851575741985, 30041.0, 31332.37335253328, 32491.35017299688, 33099.66900330966, 33127.17182070467, 33160.668393315755, 26578.601320979815, 27707.445851082462, 27900.86049569739, 28142.2964425891, 28876.566851497664, 20939.267125650527, 22762.65856012194, 22834.54330913339, 23021.309360719206, 23330.300090997298], "value": 15188.283284162997, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.7497176440017, 493.63471031436745, 498.7107477662956, 505.90134923689897, 520.5523250004995, 14018.0, 19320.613587728236, 20195.19219231229, 20196.495087622818, 20233.089510972004, 15889.602759931007, 16592.17039148041, 16636.168191590434, 16663.083530405824, 22145.33563993079, 5871.882562348761, 5992.730327135289, 6027.457528822405, 6057.697115144248, 6081.665508397036, 5916.733746981375, 5957.672328021957, 5995.550333724967, 6002.519798416116, 6030.246219222598, 5943.791967281146, 5959.374265702104, 5984.192134061911, 6006.8798624027495, 6012.669303188323, 5287.339082614692, 5703.458171473703, 5819.952408566456, 5949.821505354825, 5967.791127310545, 5260.631755777097, 5312.415634280226, 5327.547158491494, 5330.813421530228, 5338.225957236179, 23660.64509032366, 23905.760942390527, 23928.40178995539, 24040.51918961611, 24048.759512404828, 1873.4754268804757, 1894.0340426382506, 1900.1924182222501, 1903.6383087213385, 1903.8762480438727, 15561.922190389088, 16062.196890155563, 16294.75557866621, 16366.099864507447, 16838.915805421017, 2215.922442714513, 2245.5621153875, 2248.0, 2254.120892851789, 2260.4122928038664, 96921.51539242259, 99685.0, 99702.0, 108231.45884270607, 112557.0, 12483.12618116723, 12618.179818311964, 12622.30577318238, 12929.741405172032, 13185.406656700472, 19065.237390504502, 19070.04649767506, 19182.712259316122, 19231.03844807754, 19242.807571924383, 8439.831203375898, 8723.52020638871, 8771.736847894574, 8938.614514750225, 9417.71746847582, 7823.2567906048835, 7861.095973962953, 7877.645505952246, 8001.919980800118, 8006.319462845723, 8080.757577272691, 8247.298979586682, 8276.8344633107, 8366.0, 8388.790280243044, 2339.3800642829665, 2365.9763402365757, 2366.124533922425, 2400.819938504619, 2450.191436825843, 911.968081117171, 926.1011143087542, 936.283742936654, 972.4019727867311, 976.9364991275544, 17369.913150434168, 17755.644887102186, 18176.636467270582, 18217.635647287247, 18580.606454515964, 923.3582660051334, 941.6798288581915, 968.7239136845965, 984.7095106943469, 989.2531138990016, 9803.166730827817, 9873.223576920056, 10042.899571004342, 10195.235357348229, 10287.897121028695, 378544.0, 386370.0, 403147.0, 406148.0, 408416.0, 96387.0, 96849.0, 101332.0, 101463.0, 101786.4910675442, 1032.4218437674926, 1076.1713480619878, 1078.7680648660419, 1165.4813607944384, 1219.8536175658978, 15628.531144065697, 17944.820551794313, 18213.271469141087, 18885.150168242188, 19003.144858481126, 44906.10187796291, 48419.0, 48679.0, 49581.25628115509, 50171.24743128783, 62090.0, 62189.0, 62206.0669089955, 62620.0, 62985.68507157435, 10120.0, 10950.06924411434, 11064.612738554111, 11088.279261847954, 11110.944445277722, 16487.917560412123, 16778.58053548671, 16824.327026919276, 17026.233819477904, 17154.39959601408, 13675.384607692877, 14111.788323175366, 14118.929405353318, 14311.642208944859, 14367.28163591837, 12037.879621203676, 12297.938510307391, 12309.44607492647, 12541.498340066295, 12797.040221983574, 14450.638734031312, 14471.0, 14504.85495145035, 14531.709365812836, 14532.128072315694, 10267.178625709776, 10756.892431075588, 10887.074598659203, 10919.344839309666, 10927.180461465263, 14396.856031439971, 14405.567832965027, 14458.277086145861, 14508.34712437964, 14521.201333926736], "value": 10162.400691776418, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.1224173682763, 1346.898982576307, 1348.352790660483, 1350.9729805403892, 1356.7964805279207, 11751.529938802449, 12005.099617528676, 12340.0, 12362.949149322318, 12373.13388062836, 12077.335746533938, 12302.446389912453, 12302.81545776814, 12305.200161989487, 12310.076744244172, 2483.0936708101503, 2547.6688030556, 2548.745125487455, 2551.119863647039, 2553.3616595851036, 2418.2745176447083, 2452.0314475782056, 2456.9385765355833, 2457.8893949772214, 2457.913973010945, 2389.0921449849034, 2413.8793060347, 2444.1934161726676, 2445.58425067738, 2449.0, 2346.5776160291057, 2361.031976889484, 2383.332666853284, 2383.3922349800864, 2388.10446082719, 2348.8003519700846, 2353.8116950643907, 2357.622780355152, 2383.285014495644, 2388.988055059731, 11874.465649045813, 11942.104342174373, 11998.400079996052, 12006.819897701542, 12022.338771367571, 6740.8314792130095, 7003.299670033007, 7007.264237255065, 7018.40343570792, 7023.297670232936, 3986.4219688145345, 4158.189153115144, 4210.347396153601, 4224.345226489899, 4233.809478573472, 1408.3169662713576, 1467.7578199597053, 1493.4996776080027, 1493.9701205975819, 1494.0438119603355, 16587.336506539723, 17414.65170696579, 18312.725309120375, 18368.816311836843, 18371.357002504847, 5355.973220133875, 5794.246747922743, 6006.279246490361, 6009.369016253318, 6020.488258498077, 13195.274259915797, 13209.0, 13210.669733256746, 13211.867881321064, 13237.07340486176, 6845.760398386033, 6852.109225800614, 6916.515843890879, 6919.8962015569805, 6920.342567456084, 6308.369163083747, 6434.0, 6477.935220647733, 6481.092647029325, 6565.146530950946, 4279.443672322578, 4469.08383781324, 4490.528494508029, 4492.124035813051, 4526.049529598756, 1321.847987481452, 1359.4766015084265, 1365.3105181883086, 1368.5825823123844, 1386.8197134372467, 829.8008477965245, 832.6586099699215, 838.2916435611899, 848.6138806842872, 866.5667166416791, 6239.157713708682, 6256.937430625727, 6316.147320111726, 6450.903236451457, 6603.108580341688, 665.6072916978909, 691.5891581174347, 699.912510936133, 707.0348973651032, 710.6091649592703, 3879.689624830007, 4020.638142567183, 4259.020425302136, 4345.130973805251, 4404.801783919731, 15041.548753537412, 15744.842551574338, 15761.921190393974, 15812.367505299659, 15819.920900395655, 15376.308066137051, 15432.15123168214, 15450.613734656723, 15742.370305187664, 16076.43732469358, 9479.146876781122, 9605.615775369046, 9613.0, 9639.951800241095, 9674.75813104678, 6413.679316034087, 6628.635425051669, 6794.8641027180165, 7013.789586312419, 7065.470089743187, 13456.932715336361, 13915.72168556603, 14051.648708782363, 14311.713765724835, 14448.422063117358, 13213.471461141447, 14669.48656797007, 14860.851391485947, 14973.0, 15098.094114353175, 9427.0, 9921.603135874484, 10097.192224621866, 10196.541155648161, 10390.168786497214, 11003.22977391575, 11066.557337706401, 11108.833367499332, 11199.440027998731, 11282.153838461983, 8838.955805220932, 9234.861477077715, 9273.582688778886, 9546.331756777237, 9606.855897161407, 8934.151255630704, 9117.22503587176, 9155.77110572241, 9177.449353038572, 9219.216366608913, 8048.83902321962, 8092.4335296531035, 8116.918830811853, 8150.470219435718, 8196.54918979462, 5523.033469142964, 5686.346070201815, 5694.886102277848, 5937.792177273947, 5955.047192449188, 5937.881242375042, 5990.940090599038, 6067.817965461043, 6149.538784591263, 6158.538109641705], "value": 5495.299661311491, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.19025804552103, 423.8580075674649, 438.4804007251406, 446.48654047844985, 446.99106017879666, 6212.130301757752, 6263.561550691454, 6289.842753931154, 6292.937070629292, 6302.653354065525, 5879.353271140171, 6012.488938440238, 6065.8180254592435, 6069.78755743549, 6075.422834830684, 4818.373611430527, 4823.638227132961, 4851.684640498365, 4853.927191092136, 4867.0, 4805.447373552051, 4850.757462126897, 4850.878728031792, 4867.123917694814, 4870.732109733964, 4618.792154353062, 4815.422149342084, 4819.253015782542, 4830.695712157715, 4839.637027222955, 4747.12178247022, 4756.43037797526, 4771.540633041052, 4771.926316578777, 4818.229083346683, 4260.297050986584, 4277.144571085795, 4277.721948073397, 4281.464816897887, 4290.3135498320435, 5893.734781934823, 5925.259342582177, 5929.9703501482645, 5936.9406305937255, 5948.851278718067, 5488.484073506141, 5497.285352904097, 5497.945020549783, 5525.309336332958, 5530.806421775219, 6425.518086143558, 6449.516286278548, 6449.96775016122, 6463.93536064638, 6472.417482426557, 4636.09596128755, 4672.742999135046, 4676.485586585472, 4676.953230467686, 4683.555062269079, 6757.560758550679, 6782.76260330891, 6809.863802723968, 6832.385085342343, 6882.8967565486555, 4765.11845308619, 4771.379720636295, 4779.330893674888, 4782.736949467812, 4796.832110876172, 4764.190087685102, 4833.10587541306, 4833.275008748716, 4842.104210720958, 4872.0, 5537.335519737658, 5538.196961440569, 5538.335399752055, 5545.1682247663175, 5550.0, 6495.415412612793, 6518.771842985473, 6521.5108866834225, 6524.314946930599, 6559.836004099936, 1551.5888289603265, 1675.2796297592151, 1682.7812384389952, 1692.1031853117868, 1697.3974239145173, 1143.3711458697683, 1159.4260840883649, 1159.750653609478, 1159.8840115988503, 1160.4487868262509, 5689.459501347365, 5702.6293290935955, 5704.686242256633, 5705.885882282331, 5709.172170035322, 6556.27880933097, 6565.507586930904, 6566.376194261537, 6574.901376479356, 6593.8351541210895, 5666.0, 5680.857978550486, 5683.60214784961, 5685.943140568541, 5691.430856914359, 3415.7608967372043, 3491.877784277538, 3525.8540974183493, 3556.8577256909953, 3572.3034008368118, 6373.840653983688, 6398.168238129107, 6417.614943103429, 6419.711112999927, 6439.742410303629, 6775.695093720795, 6794.864102717918, 6818.2159051708695, 6818.590884546943, 6832.726690932406, 6390.968045159838, 6416.7754128605275, 6433.970564709624, 6441.935580644321, 6444.484441244689, 6593.406593406425, 6600.636964966973, 6655.201375834931, 6694.364035416627, 6711.932880671131, 6612.206535215805, 6614.875471169817, 6623.138991931018, 6630.83422914431, 6633.767818126343, 6358.109864619049, 6372.235331760218, 6379.853095487784, 6392.232932048184, 6399.232092148972, 4719.74041427711, 4756.643251756063, 4759.976200118977, 4762.785674644719, 4763.737994410202, 6635.834104147435, 6659.036728655702, 6672.83317917056, 6677.8280316849105, 6689.732410703712, 6223.688815559113, 6288.80512702585, 6431.678416079271, 6476.935230647821, 6478.704259148283, 6018.608790428783, 6167.784127555514, 6342.39747224013, 6413.807585772434, 6472.15861937945, 6310.5267104968225, 6327.588706734047, 6338.239411270677, 6359.395857393541, 6376.055303132589, 6463.547551671526, 6482.384173503509, 6510.47916166715, 6513.250976137805, 6514.57655252407, 6240.003198976284, 6278.277998030285, 6308.634262151693, 6311.873762524816, 6313.273973493107], "value": 4914.956644511519, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.4697152907552, 826.768504818651, 829.5603330234975, 840.210202409735, 840.5545061117606, 16604.252808623613, 17052.744208836848, 17134.657306853856, 17259.74110388345, 17344.653106937854, 17452.30190792367, 18596.721049184274, 18686.345977890778, 18819.43541693748, 18823.341183058597, 941.6233506597382, 964.744342749172, 967.7387105481516, 967.8209531236744, 967.8306296398138, 969.3553786731815, 969.8448248280276, 969.9175570076552, 972.0085512776964, 992.2012779712329, 1016.872890888639, 1021.7956408718248, 1022.8005538919914, 1024.7438140464883, 1027.6968294353146, 953.7853982853871, 979.1628157924943, 1015.8984101589856, 1017.6183931025828, 1028.603987464824, 738.3059923671732, 738.65283316841, 739.3013602145974, 740.5778706137504, 742.0427648333643, 16620.168991550374, 16631.6673666526, 16702.58243543921, 16929.49211523644, 16955.745663815054, 18084.186211620377, 18659.0, 18707.34524291643, 18770.155343009596, 18875.339363122224, 14873.47942822007, 14965.925170374187, 15033.624159395993, 15092.094474331576, 15119.773203401957, 3434.8282585870857, 3459.08334291413, 3459.6540345965454, 3465.2376477175235, 3465.8267086645565, 75350.0, 76835.0, 80006.19993800046, 80580.19419805786, 80878.59560702159, 15002.0, 15194.088354698753, 15307.846921530865, 15434.614134646723, 15458.768118478232, 26413.07554235631, 26872.462550748874, 26997.86501067482, 27109.86445067762, 27152.728472715415, 8717.607707653171, 8734.912650873537, 8738.082501337396, 8752.737417877473, 8795.824083518422, 3985.3822657488136, 4036.253293140778, 4040.4949381327333, 4097.508299004138, 4109.97945010273, 4222.936655950163, 4393.121375724804, 4486.439195100613, 4496.820127194876, 4577.313402989512, 902.6479672927433, 921.944683319003, 925.3245131054233, 928.1368327455397, 936.2556767369957, 596.6705781737892, 638.8051644248455, 660.7489154121403, 680.5168330485411, 693.2582137113241, 10031.891568666591, 10516.316439431412, 10916.945415272872, 10921.453927303603, 10965.122790176927, 638.5689659479832, 648.7113234610647, 649.3928177154376, 670.9329067093349, 672.3276723276723, 4511.639068874482, 4567.38340324052, 4696.882577935579, 4859.16899720337, 4870.245112007645, 84455.0, 89673.55163224142, 89864.0, 91920.0, 93307.0, 76009.0, 76153.0, 77879.0, 78713.60643196861, 80697.59651201824, 65351.673241633485, 68776.31223687799, 69967.3003269971, 70435.0, 70567.64716176386, 9639.9036009639, 9672.645829584004, 9890.208783297463, 10068.772572854563, 10100.545475453475, 29926.850365748032, 30157.69842301549, 30586.541201882435, 30755.38489230158, 31542.526862096627, 40330.59669403268, 40878.1824363517, 41300.58699412968, 53457.198142027126, 56331.71834140803, 16545.25546350393, 16625.3349866004, 17261.482155535356, 17482.650346993243, 17516.38692645751, 17877.73183402224, 18103.81896181074, 18731.438056858315, 18926.242950281834, 19084.236630534622, 14771.926140369229, 14992.100473971597, 15335.846641533442, 15410.229488525305, 15900.92049539745, 16662.75005874937, 17321.307147714455, 17504.562385940455, 17703.55741106431, 17907.10464476745, 14970.550883473514, 15016.399344026553, 15039.849601504282, 15086.094834309977, 15522.146281954601, 11893.702657433634, 12060.51757929708, 12137.453814578188, 12206.511739530319, 12356.320402377956, 13492.392842321922, 13639.79540306916, 13797.79303310431, 14618.85381146175, 14647.707045859237], "value": 8072.794817528231, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 109.0, 111.0, 111.0, 115.0, 110.0, 113.0, 110.0, 110.0, 114.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 122.0, 149.0, 159.0, 122.0, 157.0, 146.0, 122.0, 173.0, 123.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 166.0, 164.0, 167.0, 172.0, 168.0, 166.0, 165.0, 166.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 167.0, 77.0, 74.0, 74.0, 74.0, 100.0, 74.0], "value": 87.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 136.0, 85.0, 84.0, 83.0, 133.0, 83.0, 87.0, 140.0], "value": 100.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 117.0, 113.0, 114.0, 114.0, 114.0, 115.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 152.0, 153.0, 152.0, 151.0, 150.0, 150.0, 150.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 99.0, 95.0, 94.0, 95.0, 94.0, 99.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 53.0, 54.0, 54.0, 55.0, 55.0, 58.0, 56.0, 54.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 57.0, 56.0, 57.0, 57.0, 57.0, 57.0, 56.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 78.0, 83.0, 82.0, 80.0, 88.0, 80.0, 79.0, 81.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 135.0, 146.0, 136.0, 137.0, 139.0, 134.0, 134.0, 135.0, 157.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 195.0, 198.0, 195.0, 188.0, 192.0, 200.0, 196.0, 200.0, 185.0], "value": 193.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 78.0, 75.0, 73.0, 71.0, 73.0, 76.0, 73.0], "value": 74.6, "unit": "score"}]}]} 05:23:28 INFO - Return code: 0 05:23:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:23:28 INFO - # TBPL SUCCESS # 05:23:28 INFO - Running post-action listener: _resource_record_post_action 05:23:28 INFO - [mozharness: 2017-06-12 12:23:28.606709Z] Finished run-tests step (success) 05:23:28 INFO - Running post-run listener: _resource_record_post_run 05:23:28 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 40960; Write bytes: 445779968; Read time: 48; Write time: 546568 05:23:28 INFO - TinderboxPrint: CPU usage
12.7% 05:23:28 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 48 05:23:28 INFO - TinderboxPrint: I/O write bytes / time
445,779,968 / 546,568 05:23:28 INFO - TinderboxPrint: CPU idle
8,752.8 (87.3%) 05:23:28 INFO - TinderboxPrint: CPU user
1,211.9 (12.1%) 05:23:28 INFO - TinderboxPrint: Swap in / out
0 / 0 05:23:28 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 116797440; Read time: 0; Write time: 152736 05:23:28 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:23:28 INFO - run-tests - Wall time: 1238s; CPU: 13.0%; Read bytes: 36864; Write bytes: 328368128; Read time: 36; Write time: 393832 05:23:29 INFO - Running post-run listener: _upload_blobber_files 05:23:29 INFO - Blob upload gear active. 05:23:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:23:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:23:29 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:23:29 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:23:29 INFO - (blobuploader) - INFO - Open directory for files ... 05:23:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:23:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:23:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:30 INFO - (blobuploader) - INFO - Done attempting. 05:23:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:23:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:23:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:31 INFO - (blobuploader) - INFO - Done attempting. 05:23:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:23:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:23:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:32 INFO - (blobuploader) - INFO - Done attempting. 05:23:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:23:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:23:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:23:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:23:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:23:35 INFO - (blobuploader) - INFO - Done attempting. 05:23:35 INFO - (blobuploader) - INFO - Iteration through files over. 05:23:35 INFO - Return code: 0 05:23:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:23:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:23:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c9f28232b44014234331527347b4da6f5e032f22b6614ce0c5e093045c9d2a0b3b6c506ade55ea7016820ea33a64e27dffcc119c271ce2374da4c371546a11", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6979f677d0be69d7c75d277bce53abc7d90541921a1a83450778b2824c3a5487fe9e5e7a26c7d887739c4fc4272bc6fdaaf5dbfa4d0aa671b2e73d4426377fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fe0d8f31b44b439850edb0dfc0f6138ac0e6a568cd4feaf6206a3206f9b13fd0d9defe70a45157f1b01a70aae9b6d5a17a5f5a1c80d80d9bc66d312d2f4633b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3dc0296bd31bc7da3f26ac257f6d2875ab666967a26eb9c69e998d89f1ad4dbd8d3627bf8b9e1597e35ee5b3fd79b5a837086170a6d77a28739f6cb582fb9bd"} 05:23:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:23:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:23:35 INFO - Contents: 05:23:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c9f28232b44014234331527347b4da6f5e032f22b6614ce0c5e093045c9d2a0b3b6c506ade55ea7016820ea33a64e27dffcc119c271ce2374da4c371546a11", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6979f677d0be69d7c75d277bce53abc7d90541921a1a83450778b2824c3a5487fe9e5e7a26c7d887739c4fc4272bc6fdaaf5dbfa4d0aa671b2e73d4426377fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fe0d8f31b44b439850edb0dfc0f6138ac0e6a568cd4feaf6206a3206f9b13fd0d9defe70a45157f1b01a70aae9b6d5a17a5f5a1c80d80d9bc66d312d2f4633b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3dc0296bd31bc7da3f26ac257f6d2875ab666967a26eb9c69e998d89f1ad4dbd8d3627bf8b9e1597e35ee5b3fd79b5a837086170a6d77a28739f6cb582fb9bd"} 05:23:35 INFO - Running post-run listener: copy_logs_to_upload_dir 05:23:35 INFO - Copying logs to upload dir... 05:23:35 INFO - mkdir: /builds/slave/test/build/upload/logs 05:23:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.785911 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-12 05:23:35.764633) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-12 05:23:35.768200) ========= 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=781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053 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/sha512/53c9f28232b44014234331527347b4da6f5e032f22b6614ce0c5e093045c9d2a0b3b6c506ade55ea7016820ea33a64e27dffcc119c271ce2374da4c371546a11", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6979f677d0be69d7c75d277bce53abc7d90541921a1a83450778b2824c3a5487fe9e5e7a26c7d887739c4fc4272bc6fdaaf5dbfa4d0aa671b2e73d4426377fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fe0d8f31b44b439850edb0dfc0f6138ac0e6a568cd4feaf6206a3206f9b13fd0d9defe70a45157f1b01a70aae9b6d5a17a5f5a1c80d80d9bc66d312d2f4633b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3dc0296bd31bc7da3f26ac257f6d2875ab666967a26eb9c69e998d89f1ad4dbd8d3627bf8b9e1597e35ee5b3fd79b5a837086170a6d77a28739f6cb582fb9bd"} build_url:https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011176 build_url: 'https://queue.taskcluster.net/v1/task/QfHtqPEXTuOQ4r-A0GCs0w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/53c9f28232b44014234331527347b4da6f5e032f22b6614ce0c5e093045c9d2a0b3b6c506ade55ea7016820ea33a64e27dffcc119c271ce2374da4c371546a11", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6979f677d0be69d7c75d277bce53abc7d90541921a1a83450778b2824c3a5487fe9e5e7a26c7d887739c4fc4272bc6fdaaf5dbfa4d0aa671b2e73d4426377fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fe0d8f31b44b439850edb0dfc0f6138ac0e6a568cd4feaf6206a3206f9b13fd0d9defe70a45157f1b01a70aae9b6d5a17a5f5a1c80d80d9bc66d312d2f4633b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3dc0296bd31bc7da3f26ac257f6d2875ab666967a26eb9c69e998d89f1ad4dbd8d3627bf8b9e1597e35ee5b3fd79b5a837086170a6d77a28739f6cb582fb9bd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-12 05:23:35.792585) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 05:23:35.792939) ========= 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=781b77c4c33858b1f599d705000001c1-1497268683.604910-1397229053 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-12 05:23:35.878979) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-12 05:23:35.879303) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-12 05:23:35.879635) ========= ========= Total master_lag: 0.17 =========