builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1494717090.8 results: success (0) revision: 73b3fc64525b6816842c737e104ef2ac5482d217 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-13 16:11:30.803826) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-13 16:11:30.804551) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-13 16:11:30.804826) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-13 16:11:30.819218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:11:30.819488) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-13 16:11:31-- 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% 53.6M=0s 2017-05-13 16:11:31 (53.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127179 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:11:30.961500) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:11:30.961783) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015536 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:11:31.015615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-13 16:11:31.015955) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 73b3fc64525b6816842c737e104ef2ac5482d217 --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 73b3fc64525b6816842c737e104ef2ac5482d217 --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=d6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-13 16:11:31,795 truncating revision to first 12 chars 2017-05-13 16:11:31,795 Setting DEBUG logging. 2017-05-13 16:11:31,795 attempt 1/10 2017-05-13 16:11:31,795 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/73b3fc64525b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-13 16:11:32,842 unpacking tar archive at: mozilla-central-73b3fc64525b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.356060 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-13 16:11:32.385850) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-13 16:11:32.387282) ========= script_repo_revision: 73b3fc64525b6816842c737e104ef2ac5482d217 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-13 16:11:32.387660) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-13 16:11:32.387931) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-13 16:11:32.399233) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-13 16:11:32.399504) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:11:33 INFO - MultiFileLogger online at 20170513 16:11:33 in /builds/slave/test 16:11:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:11:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:11:33 INFO - {'append_to_log': False, 16:11:33 INFO - 'base_work_dir': '/builds/slave/test', 16:11:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:11:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:11:33 INFO - 'branch': 'Firefox-Non-PGO', 16:11:33 INFO - 'buildbot_json_path': 'buildprops.json', 16:11:33 INFO - 'config_files': ('talos/linux_config.py',), 16:11:33 INFO - 'default_actions': ('clobber', 16:11:33 INFO - 'read-buildbot-config', 16:11:33 INFO - 'download-and-extract', 16:11:33 INFO - 'populate-webroot', 16:11:33 INFO - 'create-virtualenv', 16:11:33 INFO - 'install', 16:11:33 INFO - 'run-tests'), 16:11:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:11:33 INFO - 'download_minidump_stackwalk': True, 16:11:33 INFO - 'download_symbols': 'ondemand', 16:11:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:11:33 INFO - 'tooltool.py': '/tools/tooltool.py', 16:11:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:11:33 INFO - '/tools/misc-python/virtualenv.py')}, 16:11:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:11:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:11:33 INFO - 'gecko_profile': False, 16:11:33 INFO - 'gecko_profile_interval': 0, 16:11:33 INFO - 'installer_path': 'installer.exe', 16:11:33 INFO - 'log_level': 'info', 16:11:33 INFO - 'log_name': 'talos', 16:11:33 INFO - 'log_to_console': True, 16:11:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:11:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:11:33 INFO - 'opt_config_files': (), 16:11:33 INFO - 'pip_index': False, 16:11:33 INFO - 'suite': 'dromaeojs-e10s', 16:11:33 INFO - 'system_bits': '32', 16:11:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:11:33 INFO - 'title': 'talos-linux64-ix-034', 16:11:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:11:33 INFO - 'use_talos_json': True, 16:11:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:11:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:11:33 INFO - 'work_dir': 'build'} 16:11:33 INFO - [mozharness: 2017-05-13 23:11:33.277205Z] Running clobber step. 16:11:33 INFO - Running pre-action listener: _resource_record_pre_action 16:11:33 INFO - Running main action method: clobber 16:11:33 INFO - rmtree: /builds/slave/test/build 16:11:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:11:34 INFO - Running post-action listener: _resource_record_post_action 16:11:34 INFO - [mozharness: 2017-05-13 23:11:34.792618Z] Finished clobber step (success) 16:11:34 INFO - [mozharness: 2017-05-13 23:11:34.792716Z] Running read-buildbot-config step. 16:11:34 INFO - Running pre-action listener: _resource_record_pre_action 16:11:34 INFO - Running main action method: read_buildbot_config 16:11:34 INFO - Using buildbot properties: 16:11:34 INFO - { 16:11:34 INFO - "project": "", 16:11:34 INFO - "product": "firefox", 16:11:34 INFO - "who": "archaeopteryx@coole-files.de", 16:11:34 INFO - "installer_path": "public/build/target.tar.bz2", 16:11:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:11:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:11:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:11:34 INFO - "stage_platform": "linux64", 16:11:34 INFO - "basedir": "/builds/slave/test", 16:11:34 INFO - "buildnumber": 599, 16:11:34 INFO - "platform": "ubuntu64_hw", 16:11:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:11:34 INFO - "slavebuilddir": "test", 16:11:34 INFO - "taskId": "VfxaChqOR_-wZjK62-zA4g", 16:11:34 INFO - "branch": "mozilla-central", 16:11:34 INFO - "script_repo_revision": "production", 16:11:34 INFO - "revision": "73b3fc64525b6816842c737e104ef2ac5482d217", 16:11:34 INFO - "slavename": "talos-linux64-ix-034", 16:11:34 INFO - "repo_path": "mozilla-central" 16:11:34 INFO - } 16:11:34 INFO - Finding installer, test and symbols from parent task. 16:11:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VfxaChqOR_-wZjK62-zA4g'}, attempt #1 16:11:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VfxaChqOR_-wZjK62-zA4g'}, attempt #1 16:11:35 INFO - Task dependencies: Zpk4sgI2Q8SzGk9aKnzCGg 16:11:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg'}, attempt #1 16:11:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.tar.bz2 16:11:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/test_packages.json 16:11:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.crashreporter-symbols.zip 16:11:36 INFO - Running post-action listener: _resource_record_post_action 16:11:36 INFO - [mozharness: 2017-05-13 23:11:36.142291Z] Finished read-buildbot-config step (success) 16:11:36 INFO - [mozharness: 2017-05-13 23:11:36.142507Z] Running download-and-extract step. 16:11:36 INFO - Running pre-action listener: _resource_record_pre_action 16:11:36 INFO - Running main action method: download_and_extract 16:11:36 INFO - mkdir: /builds/slave/test/build/tests 16:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:11:36 INFO - trying https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.test_packages.json 16:11:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:11:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:11:36 INFO - Downloaded 986 bytes. 16:11:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:11:36 INFO - Using the following test package requirements: 16:11:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:11:36 INFO - u'common': [u'target.common.tests.zip'], 16:11:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:11:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:11:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:11:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:11:36 INFO - u'mozbase': [u'target.common.tests.zip'], 16:11:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:11:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:11:36 INFO - u'web-platform': [u'target.common.tests.zip', 16:11:36 INFO - u'target.web-platform.tests.zip'], 16:11:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:11:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:11:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.common.tests.zip 16:11:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:11:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.common.tests.zip into memory 16:11:37 INFO - Content-Length response header: 62447311 16:11:37 INFO - Bytes received: 62447311 16:11:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:11:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.common.tests.zip 16:11:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:11:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.common.tests.zip into memory 16:11:49 INFO - Content-Length response header: 62447311 16:11:49 INFO - Bytes received: 62447311 16:12:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.talos.tests.zip 16:12:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:12:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.talos.tests.zip into memory 16:12:01 INFO - Content-Length response header: 14409411 16:12:01 INFO - Bytes received: 14409411 16:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:02 INFO - trying https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.tar.bz2 16:12:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:12:03 INFO - Downloaded 63426817 bytes. 16:12:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.tar.bz2 16:12:03 INFO - mkdir: /builds/slave/test/properties 16:12:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:12:03 INFO - Writing to file /builds/slave/test/properties/build_url 16:12:03 INFO - Contents: 16:12:03 INFO - build_url:https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.tar.bz2 16:12:03 INFO - Running post-action listener: _resource_record_post_action 16:12:03 INFO - Running post-action listener: set_extra_try_arguments 16:12:03 INFO - [mozharness: 2017-05-13 23:12:03.322458Z] Finished download-and-extract step (success) 16:12:03 INFO - [mozharness: 2017-05-13 23:12:03.322555Z] Running populate-webroot step. 16:12:03 INFO - Running pre-action listener: _resource_record_pre_action 16:12:03 INFO - Running main action method: populate_webroot 16:12:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:12:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:12:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:12:03 INFO - '--tppagecycles', 16:12:03 INFO - '7'], 16:12:03 INFO - 'tests': ['tsvgm']}}, 16:12:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:12:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:12:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:12:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:12:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:12:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:12:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:12:03 INFO - 'talos_options': ['--disable-e10s'], 16:12:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:12:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:12:03 INFO - 'talos_options': ['--disable-e10s'], 16:12:03 INFO - 'tests': ['damp', 'tps']}, 16:12:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:12:03 INFO - 'tests': ['damp', 'tps']}, 16:12:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:12:03 INFO - 'tests': ['dromaeo_dom']}, 16:12:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:12:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:12:03 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:12:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:12:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:12:03 INFO - 'tests': ['a11yr', 16:12:03 INFO - 'ts_paint', 16:12:03 INFO - 'tpaint', 16:12:03 INFO - 'sessionrestore', 16:12:03 INFO - 'sessionrestore_no_auto_restore', 16:12:03 INFO - 'tabpaint']}, 16:12:03 INFO - 'other-e10s': {'tests': ['a11yr', 16:12:03 INFO - 'ts_paint', 16:12:03 INFO - 'tpaint', 16:12:03 INFO - 'sessionrestore', 16:12:03 INFO - 'sessionrestore_no_auto_restore', 16:12:03 INFO - 'tabpaint']}, 16:12:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:12:03 INFO - 'ts_paint', 16:12:03 INFO - 'tpaint', 16:12:03 INFO - 'sessionrestore', 16:12:03 INFO - 'sessionrestore_no_auto_restore', 16:12:03 INFO - 'tabpaint']}, 16:12:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:12:03 INFO - 'ts_paint', 16:12:03 INFO - 'tpaint', 16:12:03 INFO - 'sessionrestore', 16:12:03 INFO - 'sessionrestore_no_auto_restore', 16:12:03 INFO - 'tabpaint']}, 16:12:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:12:03 INFO - 'tests': ['a11yr', 16:12:03 INFO - 'ts_paint', 16:12:03 INFO - 'tpaint', 16:12:03 INFO - 'sessionrestore', 16:12:03 INFO - 'sessionrestore_no_auto_restore', 16:12:03 INFO - 'tabpaint']}, 16:12:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:12:03 INFO - 'tests': ['a11yr', 16:12:03 INFO - 'ts_paint', 16:12:03 INFO - 'tpaint', 16:12:03 INFO - 'sessionrestore', 16:12:03 INFO - 'sessionrestore_no_auto_restore', 16:12:03 INFO - 'tabpaint']}, 16:12:03 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:12:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:12:03 INFO - 'bloom_basic_ref']}, 16:12:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:12:03 INFO - 'tests': ['tsvgx', 16:12:03 INFO - 'tsvgr_opacity', 16:12:03 INFO - 'tart', 16:12:03 INFO - 'tscrollx', 16:12:03 INFO - 'cart', 16:12:03 INFO - 'tsvg_static']}, 16:12:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:12:03 INFO - 'tsvgr_opacity', 16:12:03 INFO - 'tart', 16:12:03 INFO - 'tscrollx', 16:12:03 INFO - 'cart', 16:12:03 INFO - 'tsvg_static']}, 16:12:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:12:03 INFO - 'talos_options': ['--disable-e10s'], 16:12:03 INFO - 'tests': ['tp5o']}, 16:12:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:12:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:12:03 INFO - 'talos_options': ['--disable-e10s', 16:12:03 INFO - '--xperf_path', 16:12:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:03 INFO - 'tests': ['tp5n']}, 16:12:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:12:03 INFO - 'talos_options': ['--xperf_path', 16:12:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:03 INFO - 'tests': ['tp5n']}}, 16:12:03 INFO - 'talos.zip': {'path': '', 16:12:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:12:03 INFO - Running post-action listener: _resource_record_post_action 16:12:03 INFO - [mozharness: 2017-05-13 23:12:03.336206Z] Finished populate-webroot step (success) 16:12:03 INFO - [mozharness: 2017-05-13 23:12:03.336296Z] Running create-virtualenv step. 16:12:03 INFO - Running pre-action listener: _resource_record_pre_action 16:12:03 INFO - Running main action method: create_virtualenv 16:12:03 INFO - Creating virtualenv /builds/slave/test/build/venv 16:12:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:12:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:12:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:12:03 INFO - Using real prefix '/usr' 16:12:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:12:03 INFO - Installing distribute.............................................................................................................................................................................................done. 16:12:05 INFO - Installing pip.................done. 16:12:05 INFO - Return code: 0 16:12:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:12:06 INFO - Reading from file tmpfile_stdout 16:12:06 INFO - Output received: 16:12:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:12:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:06 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 0x15b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a30>, '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 0x19297f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929ca0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:12:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:12:06 INFO - Using env: {'DISPLAY': ':0', 16:12:06 INFO - 'HOME': '/home/cltbld', 16:12:06 INFO - 'LANG': 'en_US.UTF-8', 16:12:06 INFO - 'LANGUAGE': 'en_US:en', 16:12:06 INFO - 'LOGNAME': 'cltbld', 16:12:06 INFO - 'MAIL': '/var/mail/cltbld', 16:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:06 INFO - 'MOZ_NO_REMOTE': '1', 16:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:06 INFO - 'NO_EM_RESTART': '1', 16:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:06 INFO - 'PWD': '/builds/slave/test', 16:12:06 INFO - 'SHELL': '/bin/bash', 16:12:06 INFO - 'SHLVL': '1', 16:12:06 INFO - 'TERM': 'linux', 16:12:06 INFO - 'TMOUT': '86400', 16:12:06 INFO - 'USER': 'cltbld', 16:12:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 16:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:06 INFO - '_': '/tools/buildbot/bin/python'} 16:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:12:06 INFO - Cleaning up... 16:12:06 INFO - Return code: 0 16:12:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:06 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 0x15b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a30>, '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 0x19297f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929ca0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:12:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:12:06 INFO - Using env: {'DISPLAY': ':0', 16:12:06 INFO - 'HOME': '/home/cltbld', 16:12:06 INFO - 'LANG': 'en_US.UTF-8', 16:12:06 INFO - 'LANGUAGE': 'en_US:en', 16:12:06 INFO - 'LOGNAME': 'cltbld', 16:12:06 INFO - 'MAIL': '/var/mail/cltbld', 16:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:06 INFO - 'MOZ_NO_REMOTE': '1', 16:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:06 INFO - 'NO_EM_RESTART': '1', 16:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:06 INFO - 'PWD': '/builds/slave/test', 16:12:06 INFO - 'SHELL': '/bin/bash', 16:12:06 INFO - 'SHLVL': '1', 16:12:06 INFO - 'TERM': 'linux', 16:12:06 INFO - 'TMOUT': '86400', 16:12:06 INFO - 'USER': 'cltbld', 16:12:06 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 16:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:06 INFO - '_': '/tools/buildbot/bin/python'} 16:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:06 INFO - Downloading/unpacking psutil>=3.1.1 16:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:12:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:07 INFO - Installing collected packages: psutil 16:12:07 INFO - Running setup.py install for psutil 16:12:07 INFO - building 'psutil._psutil_linux' extension 16:12:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:12:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:12:08 INFO - building 'psutil._psutil_posix' extension 16:12:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:12:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:12:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:12:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:12:08 INFO - Successfully installed psutil 16:12:08 INFO - Cleaning up... 16:12:08 INFO - Return code: 0 16:12:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:08 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 0x15b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a30>, '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 0x19297f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929ca0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:12:08 INFO - Using env: {'DISPLAY': ':0', 16:12:08 INFO - 'HOME': '/home/cltbld', 16:12:08 INFO - 'LANG': 'en_US.UTF-8', 16:12:08 INFO - 'LANGUAGE': 'en_US:en', 16:12:08 INFO - 'LOGNAME': 'cltbld', 16:12:08 INFO - 'MAIL': '/var/mail/cltbld', 16:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:08 INFO - 'MOZ_NO_REMOTE': '1', 16:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:08 INFO - 'NO_EM_RESTART': '1', 16:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:08 INFO - 'PWD': '/builds/slave/test', 16:12:08 INFO - 'SHELL': '/bin/bash', 16:12:08 INFO - 'SHLVL': '1', 16:12:08 INFO - 'TERM': 'linux', 16:12:08 INFO - 'TMOUT': '86400', 16:12:08 INFO - 'USER': 'cltbld', 16:12:08 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 16:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:08 INFO - '_': '/tools/buildbot/bin/python'} 16:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:12:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:12:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:12:09 INFO - Installing collected packages: mozsystemmonitor 16:12:09 INFO - Running setup.py install for mozsystemmonitor 16:12:09 INFO - Successfully installed mozsystemmonitor 16:12:09 INFO - Cleaning up... 16:12:09 INFO - Return code: 0 16:12:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:09 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 0x15b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a30>, '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 0x19297f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929ca0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:12:09 INFO - Using env: {'DISPLAY': ':0', 16:12:09 INFO - 'HOME': '/home/cltbld', 16:12:09 INFO - 'LANG': 'en_US.UTF-8', 16:12:09 INFO - 'LANGUAGE': 'en_US:en', 16:12:09 INFO - 'LOGNAME': 'cltbld', 16:12:09 INFO - 'MAIL': '/var/mail/cltbld', 16:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:09 INFO - 'MOZ_NO_REMOTE': '1', 16:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:09 INFO - 'NO_EM_RESTART': '1', 16:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:09 INFO - 'PWD': '/builds/slave/test', 16:12:09 INFO - 'SHELL': '/bin/bash', 16:12:09 INFO - 'SHLVL': '1', 16:12:09 INFO - 'TERM': 'linux', 16:12:09 INFO - 'TMOUT': '86400', 16:12:09 INFO - 'USER': 'cltbld', 16:12:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 16:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:09 INFO - '_': '/tools/buildbot/bin/python'} 16:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:09 INFO - Downloading/unpacking jsonschema==2.5.1 16:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:12:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:11 INFO - Downloading functools32-3.2.3-2.tar.gz 16:12:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:12:11 INFO - warning: no files found matching '*.txt' 16:12:11 INFO - no previously-included directories found matching 'build' 16:12:11 INFO - no previously-included directories found matching 'dist' 16:12:11 INFO - no previously-included directories found matching '.git*' 16:12:11 INFO - Installing collected packages: jsonschema, functools32 16:12:11 INFO - Running setup.py install for functools32 16:12:11 INFO - warning: no files found matching '*.txt' 16:12:11 INFO - no previously-included directories found matching 'build' 16:12:11 INFO - no previously-included directories found matching 'dist' 16:12:11 INFO - no previously-included directories found matching '.git*' 16:12:11 INFO - Successfully installed jsonschema functools32 16:12:11 INFO - Cleaning up... 16:12:11 INFO - Return code: 0 16:12:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:11 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 0x15b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a30>, '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 0x19297f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929ca0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:12:11 INFO - Using env: {'DISPLAY': ':0', 16:12:11 INFO - 'HOME': '/home/cltbld', 16:12:11 INFO - 'LANG': 'en_US.UTF-8', 16:12:11 INFO - 'LANGUAGE': 'en_US:en', 16:12:11 INFO - 'LOGNAME': 'cltbld', 16:12:11 INFO - 'MAIL': '/var/mail/cltbld', 16:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:11 INFO - 'MOZ_NO_REMOTE': '1', 16:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:11 INFO - 'NO_EM_RESTART': '1', 16:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:11 INFO - 'PWD': '/builds/slave/test', 16:12:11 INFO - 'SHELL': '/bin/bash', 16:12:11 INFO - 'SHLVL': '1', 16:12:11 INFO - 'TERM': 'linux', 16:12:11 INFO - 'TMOUT': '86400', 16:12:11 INFO - 'USER': 'cltbld', 16:12:11 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 16:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:11 INFO - '_': '/tools/buildbot/bin/python'} 16:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:12:11 INFO - Cleaning up... 16:12:11 INFO - Return code: 0 16:12:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:11 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 0x15b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a30>, '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 0x19297f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929ca0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:12:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:12:11 INFO - Using env: {'DISPLAY': ':0', 16:12:11 INFO - 'HOME': '/home/cltbld', 16:12:11 INFO - 'LANG': 'en_US.UTF-8', 16:12:11 INFO - 'LANGUAGE': 'en_US:en', 16:12:11 INFO - 'LOGNAME': 'cltbld', 16:12:11 INFO - 'MAIL': '/var/mail/cltbld', 16:12:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:11 INFO - 'MOZ_NO_REMOTE': '1', 16:12:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:11 INFO - 'NO_EM_RESTART': '1', 16:12:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:11 INFO - 'PWD': '/builds/slave/test', 16:12:11 INFO - 'SHELL': '/bin/bash', 16:12:11 INFO - 'SHLVL': '1', 16:12:11 INFO - 'TERM': 'linux', 16:12:11 INFO - 'TMOUT': '86400', 16:12:11 INFO - 'USER': 'cltbld', 16:12:11 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 16:12:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:11 INFO - '_': '/tools/buildbot/bin/python'} 16:12:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:11 INFO - Downloading/unpacking blobuploader==1.2.4 16:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:12 INFO - Downloading blobuploader-1.2.4.tar.gz 16:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:12:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:12:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:12:13 INFO - Downloading docopt-0.6.1.tar.gz 16:12:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:12:13 INFO - Installing collected packages: blobuploader, requests, docopt 16:12:13 INFO - Running setup.py install for blobuploader 16:12:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:12:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:12:13 INFO - Running setup.py install for requests 16:12:14 INFO - Running setup.py install for docopt 16:12:14 INFO - Successfully installed blobuploader requests docopt 16:12:14 INFO - Cleaning up... 16:12:14 INFO - Return code: 0 16:12:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:14 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 0x15b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a30>, '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 0x19297f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929ca0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:12:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:12:14 INFO - Using env: {'DISPLAY': ':0', 16:12:14 INFO - 'HOME': '/home/cltbld', 16:12:14 INFO - 'LANG': 'en_US.UTF-8', 16:12:14 INFO - 'LANGUAGE': 'en_US:en', 16:12:14 INFO - 'LOGNAME': 'cltbld', 16:12:14 INFO - 'MAIL': '/var/mail/cltbld', 16:12:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:14 INFO - 'MOZ_NO_REMOTE': '1', 16:12:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:14 INFO - 'NO_EM_RESTART': '1', 16:12:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:14 INFO - 'PWD': '/builds/slave/test', 16:12:14 INFO - 'SHELL': '/bin/bash', 16:12:14 INFO - 'SHLVL': '1', 16:12:14 INFO - 'TERM': 'linux', 16:12:14 INFO - 'TMOUT': '86400', 16:12:14 INFO - 'USER': 'cltbld', 16:12:14 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 16:12:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:14 INFO - '_': '/tools/buildbot/bin/python'} 16:12:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:14 INFO - Running setup.py (path:/tmp/pip-UTaLo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:14 INFO - Running setup.py (path:/tmp/pip-MSa38x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:14 INFO - Running setup.py (path:/tmp/pip-sGeQ17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:14 INFO - Running setup.py (path:/tmp/pip-eGlHFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:14 INFO - Running setup.py (path:/tmp/pip-XDtgQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:14 INFO - Running setup.py (path:/tmp/pip-8Gs8cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:14 INFO - Running setup.py (path:/tmp/pip-sJQ93p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:15 INFO - Running setup.py (path:/tmp/pip-gGTHqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:15 INFO - Running setup.py (path:/tmp/pip-2A7ngE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:15 INFO - Running setup.py (path:/tmp/pip-GwY02M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:15 INFO - Running setup.py (path:/tmp/pip-xzNhwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:15 INFO - Running setup.py (path:/tmp/pip-7C6qK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:15 INFO - Running setup.py (path:/tmp/pip-KVAGo6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:15 INFO - Running setup.py (path:/tmp/pip-OHVwg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:15 INFO - Running setup.py (path:/tmp/pip-Foj7AF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:15 INFO - Running setup.py (path:/tmp/pip-29PrNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:15 INFO - Running setup.py (path:/tmp/pip-D4y1PZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:12:15 INFO - Running setup.py install for manifestparser 16:12:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:12:15 INFO - Running setup.py install for mozcrash 16:12:15 INFO - Running setup.py install for mozdebug 16:12:16 INFO - Running setup.py install for mozdevice 16:12:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Running setup.py install for mozfile 16:12:16 INFO - Running setup.py install for mozhttpd 16:12:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Running setup.py install for mozinfo 16:12:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Running setup.py install for mozInstall 16:12:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Running setup.py install for mozleak 16:12:16 INFO - Running setup.py install for mozlog 16:12:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Running setup.py install for moznetwork 16:12:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:12:16 INFO - Running setup.py install for mozprocess 16:12:16 INFO - Running setup.py install for mozprofile 16:12:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:12:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:12:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:12:17 INFO - Running setup.py install for mozrunner 16:12:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:12:17 INFO - Running setup.py install for mozscreenshot 16:12:17 INFO - Running setup.py install for moztest 16:12:17 INFO - Running setup.py install for mozversion 16:12:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:12:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:12:17 INFO - Cleaning up... 16:12:17 INFO - Return code: 0 16:12:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:17 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 0x15b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a30>, '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 0x19297f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929ca0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:12:17 INFO - Using env: {'DISPLAY': ':0', 16:12:17 INFO - 'HOME': '/home/cltbld', 16:12:17 INFO - 'LANG': 'en_US.UTF-8', 16:12:17 INFO - 'LANGUAGE': 'en_US:en', 16:12:17 INFO - 'LOGNAME': 'cltbld', 16:12:17 INFO - 'MAIL': '/var/mail/cltbld', 16:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:17 INFO - 'MOZ_NO_REMOTE': '1', 16:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:17 INFO - 'NO_EM_RESTART': '1', 16:12:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:17 INFO - 'PWD': '/builds/slave/test', 16:12:17 INFO - 'SHELL': '/bin/bash', 16:12:17 INFO - 'SHLVL': '1', 16:12:17 INFO - 'TERM': 'linux', 16:12:17 INFO - 'TMOUT': '86400', 16:12:17 INFO - 'USER': 'cltbld', 16:12:17 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 16:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:17 INFO - '_': '/tools/buildbot/bin/python'} 16:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:12:17 INFO - Running setup.py (path:/tmp/pip-MnXxsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:12:17 INFO - Running setup.py (path:/tmp/pip-GnSry6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:12:17 INFO - Running setup.py (path:/tmp/pip-TtWaCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:12:17 INFO - Running setup.py (path:/tmp/pip-TkMiaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:12:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:12:17 INFO - Running setup.py (path:/tmp/pip-iUcaUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:12:18 INFO - Running setup.py (path:/tmp/pip-qhpAVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:12:18 INFO - Running setup.py (path:/tmp/pip-VUlMMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:12:18 INFO - Running setup.py (path:/tmp/pip-CWePqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:12:18 INFO - Running setup.py (path:/tmp/pip-8tts5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:12:18 INFO - Running setup.py (path:/tmp/pip-mxTRcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:12:18 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)) 16:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:12:18 INFO - Running setup.py (path:/tmp/pip-X6lW63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:12:18 INFO - Running setup.py (path:/tmp/pip-L4W92j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:12:18 INFO - Running setup.py (path:/tmp/pip-jAgUEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:12:18 INFO - Running setup.py (path:/tmp/pip-WR8oPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:18 INFO - Running setup.py (path:/tmp/pip-g0u64F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:12:18 INFO - Running setup.py (path:/tmp/pip-aTyt9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:12:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:12:18 INFO - Running setup.py (path:/tmp/pip-7qQnlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:12:18 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:12:18 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:12:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:12: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 16:12: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 16:12: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 16:12: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 16:12:20 INFO - Downloading blessings-1.6.tar.gz 16:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:12:20 INFO - Installing collected packages: blessings 16:12:20 INFO - Running setup.py install for blessings 16:12:20 INFO - Successfully installed blessings 16:12:20 INFO - Cleaning up... 16:12:20 INFO - Return code: 0 16:12:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:12:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:20 INFO - Reading from file tmpfile_stdout 16:12:20 INFO - Current package versions: 16:12:20 INFO - argparse == 1.2.1 16:12:20 INFO - blessings == 1.6 16:12:20 INFO - blobuploader == 1.2.4 16:12:20 INFO - docopt == 0.6.1 16:12:20 INFO - functools32 == 3.2.3-2 16:12:20 INFO - jsonschema == 2.5.1 16:12:20 INFO - manifestparser == 1.1 16:12:20 INFO - mozInstall == 1.12 16:12:20 INFO - mozcrash == 1.0 16:12:20 INFO - mozdebug == 0.1 16:12:20 INFO - mozdevice == 0.50 16:12:20 INFO - mozfile == 1.2 16:12:20 INFO - mozhttpd == 0.7 16:12:20 INFO - mozinfo == 0.9 16:12:20 INFO - mozleak == 0.1 16:12:20 INFO - mozlog == 3.4 16:12:20 INFO - moznetwork == 0.27 16:12:20 INFO - mozprocess == 0.25 16:12:20 INFO - mozprofile == 0.28 16:12:20 INFO - mozrunner == 6.13 16:12:20 INFO - mozscreenshot == 0.1 16:12:20 INFO - mozsystemmonitor == 0.3 16:12:20 INFO - moztest == 0.8 16:12:20 INFO - mozversion == 1.4 16:12:20 INFO - psutil == 3.1.1 16:12:20 INFO - requests == 1.2.3 16:12:20 INFO - wsgiref == 0.1.2 16:12:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12: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')]} 16:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:20 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 0x15b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a30>, '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 0x19297f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929ca0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:12:20 INFO - Using env: {'DISPLAY': ':0', 16:12:20 INFO - 'HOME': '/home/cltbld', 16:12:20 INFO - 'LANG': 'en_US.UTF-8', 16:12:20 INFO - 'LANGUAGE': 'en_US:en', 16:12:20 INFO - 'LOGNAME': 'cltbld', 16:12:20 INFO - 'MAIL': '/var/mail/cltbld', 16:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:20 INFO - 'MOZ_NO_REMOTE': '1', 16:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:20 INFO - 'NO_EM_RESTART': '1', 16:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:20 INFO - 'PWD': '/builds/slave/test', 16:12:20 INFO - 'SHELL': '/bin/bash', 16:12:20 INFO - 'SHLVL': '1', 16:12:20 INFO - 'TERM': 'linux', 16:12:20 INFO - 'TMOUT': '86400', 16:12:20 INFO - 'USER': 'cltbld', 16:12:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 16:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:20 INFO - '_': '/tools/buildbot/bin/python'} 16:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:12:20 INFO - Cleaning up... 16:12:20 INFO - Return code: 0 16:12:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:12: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')]} 16:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12: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')]} 16:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1785a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192b770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1928a30>, '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 0x19297f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929ca0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:12: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'] in /builds/slave/test/build 16:12: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 16:12:20 INFO - Using env: {'DISPLAY': ':0', 16:12:20 INFO - 'HOME': '/home/cltbld', 16:12:20 INFO - 'LANG': 'en_US.UTF-8', 16:12:20 INFO - 'LANGUAGE': 'en_US:en', 16:12:20 INFO - 'LOGNAME': 'cltbld', 16:12:20 INFO - 'MAIL': '/var/mail/cltbld', 16:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:20 INFO - 'MOZ_NO_REMOTE': '1', 16:12:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:20 INFO - 'NO_EM_RESTART': '1', 16:12:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:20 INFO - 'PWD': '/builds/slave/test', 16:12:20 INFO - 'SHELL': '/bin/bash', 16:12:20 INFO - 'SHLVL': '1', 16:12:20 INFO - 'TERM': 'linux', 16:12:20 INFO - 'TMOUT': '86400', 16:12:20 INFO - 'USER': 'cltbld', 16:12:20 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 16:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:20 INFO - '_': '/tools/buildbot/bin/python'} 16:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:12:20 INFO - Cleaning up... 16:12:20 INFO - Return code: 0 16:12:20 INFO - Running post-action listener: _resource_record_post_action 16:12:20 INFO - Running post-action listener: _start_resource_monitoring 16:12:20 INFO - Starting resource monitoring. 16:12:20 INFO - [mozharness: 2017-05-13 23:12:20.962658Z] Finished create-virtualenv step (success) 16:12:20 INFO - [mozharness: 2017-05-13 23:12:20.963171Z] Running install step. 16:12:20 INFO - Running pre-action listener: _resource_record_pre_action 16:12:20 INFO - Running main action method: install 16:12:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:21 INFO - Reading from file tmpfile_stdout 16:12:21 INFO - Detecting whether we're running mozinstall >=1.0... 16:12:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:12:21 INFO - Reading from file tmpfile_stdout 16:12:21 INFO - Output received: 16:12:21 INFO - Usage: mozinstall [options] installer 16:12:21 INFO - Options: 16:12:21 INFO - -h, --help show this help message and exit 16:12:21 INFO - -d DEST, --destination=DEST 16:12:21 INFO - Directory to install application into. [default: 16:12:21 INFO - "/builds/slave/test"] 16:12:21 INFO - --app=APP Application being installed. [default: firefox] 16:12:21 INFO - mkdir: /builds/slave/test/build/application 16:12:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:12:37 INFO - Reading from file tmpfile_stdout 16:12:37 INFO - Output received: 16:12:37 INFO - /builds/slave/test/build/application/firefox/firefox 16:12:37 INFO - Running post-action listener: _resource_record_post_action 16:12:37 INFO - [mozharness: 2017-05-13 23:12:37.632766Z] Finished install step (success) 16:12:37 INFO - [mozharness: 2017-05-13 23:12:37.633011Z] Running run-tests step. 16:12:37 INFO - Running pre-action listener: _resource_record_pre_action 16:12:37 INFO - Running main action method: run_tests 16:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:12:37 INFO - Python 2.7.3 16:12:37 INFO - Return code: 0 16:12:37 INFO - grabbing minidump binary from tooltool 16:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:37 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 0x1928a30>, '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 0x19297f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:12:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:12:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:12:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:12:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:12:37 INFO - Return code: 0 16:12:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:12:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:12:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:12:37 INFO - ENV: RUST_BACKTRACE is now 1 16:12:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:12:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:12:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:12:37 INFO - Using env: {'DISPLAY': ':0', 16:12:37 INFO - 'HOME': '/home/cltbld', 16:12:37 INFO - 'LANG': 'en_US.UTF-8', 16:12:37 INFO - 'LANGUAGE': 'en_US:en', 16:12:37 INFO - 'LOGNAME': 'cltbld', 16:12:37 INFO - 'MAIL': '/var/mail/cltbld', 16:12:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:12:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:37 INFO - 'MOZ_NO_REMOTE': '1', 16:12:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:12:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:12:37 INFO - 'NO_EM_RESTART': '1', 16:12:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:37 INFO - 'PWD': '/builds/slave/test', 16:12:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:12:37 INFO - 'RUST_BACKTRACE': '1', 16:12:37 INFO - 'SHELL': '/bin/bash', 16:12:37 INFO - 'SHLVL': '1', 16:12:37 INFO - 'TERM': 'linux', 16:12:37 INFO - 'TMOUT': '86400', 16:12:37 INFO - 'USER': 'cltbld', 16:12:37 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789', 16:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:37 INFO - '_': '/tools/buildbot/bin/python'} 16:12:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:12:37 INFO - mozversion application_buildid: 20170513223750 16:12:37 INFO - mozversion application_changeset: 73b3fc64525b6816842c737e104ef2ac5482d217 16:12:37 INFO - mozversion application_display_name: Nightly 16:12:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:12:37 INFO - mozversion application_name: Firefox 16:12:37 INFO - mozversion application_remotingname: firefox 16:12:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:12:37 INFO - mozversion application_vendor: Mozilla 16:12:37 INFO - mozversion application_version: 55.0a1 16:12:37 INFO - mozversion platform_buildid: 20170513223750 16:12:37 INFO - mozversion platform_changeset: 73b3fc64525b6816842c737e104ef2ac5482d217 16:12:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:12:37 INFO - mozversion platform_version: 55.0a1 16:12:37 INFO - using testdate: 1494717157 16:12:37 INFO - actual date: 1494717157 16:12:37 INFO - starting webserver on 'localhost:34559' 16:12:37 INFO - SUITE-START | Running 2 tests 16:12:37 INFO - TEST-START | dromaeo_css 16:12:37 INFO - operating with platform_type : linux_ 16:12:37 INFO - Initialising browser for dromaeo_css test... 16:12:37 INFO - TEST-INFO | started process 18410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkC9r38/profile http://localhost:34559/getInfo.html) 16:12:42 INFO - PID 18410 | __metrics Screen width/height:1600/1200 16:12:42 INFO - PID 18410 | colorDepth:24 16:12:42 INFO - PID 18410 | Browser inner width/height: 1024/695 16:12:42 INFO - PID 18410 | __metrics 16:12:44 INFO - TEST-INFO | 18410: exit 0 16:12:44 INFO - Browser initialized. 16:12:44 INFO - Running cycle 1/1 for dromaeo_css test... 16:12:44 INFO - TEST-INFO | started process 18583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkC9r38/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:56 INFO - PID 18583 | RSS: Main: 156176384 16:12:56 INFO - PID 18583 | 16:16:01 INFO - PID 18583 | Cycle 1(1): loaded http://localhost:34559/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34559/tests/dromaeo/cssquery-ext.html) 16:16:03 INFO - PID 18583 | RSS: Main: 165474304 16:16:03 INFO - PID 18583 | 16:19:05 INFO - PID 18583 | Cycle 1(1): loaded http://localhost:34559/tests/dromaeo/cssquery-ext.html (next: http://localhost:34559/tests/dromaeo/cssquery-jquery.html) 16:19:06 INFO - PID 18583 | RSS: Main: 161120256 16:19:06 INFO - PID 18583 | 16:22:08 INFO - PID 18583 | Cycle 1(1): loaded http://localhost:34559/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34559/tests/dromaeo/cssquery-mootools.html) 16:22:08 INFO - PID 18583 | RSS: Main: 167501824 16:22:08 INFO - PID 18583 | 16:25:10 INFO - PID 18583 | Cycle 1(1): loaded http://localhost:34559/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34559/tests/dromaeo/cssquery-prototype.html) 16:25:11 INFO - PID 18583 | RSS: Main: 160632832 16:25:11 INFO - PID 18583 | 16:28:14 INFO - PID 18583 | Cycle 1(1): loaded http://localhost:34559/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34559/tests/dromaeo/cssquery-yui.html) 16:28:14 INFO - PID 18583 | RSS: Main: 165257216 16:28:14 INFO - PID 18583 | 16:31:16 INFO - PID 18583 | Cycle 1(1): loaded http://localhost:34559/tests/dromaeo/cssquery-yui.html (next: http://localhost:34559/tests/dromaeo/cssquery-dojo.html) 16:31:16 INFO - PID 18583 | RSS: Main: 168886272 16:31:16 INFO - PID 18583 | 16:31:16 INFO - PID 18583 | __start_tp_report 16:31:16 INFO - PID 18583 | _x_x_mozilla_page_load 16:31:16 INFO - PID 18583 | _x_x_mozilla_page_load_details 16:31:16 INFO - PID 18583 | |i|pagename|runs| 16:31:16 INFO - PID 18583 | |0;dojo.html;2758.737919897609;2769.0862015534876;2782.888684452622;2802.341449759306;2805.593188987596;5276.7889284428675;5314.309139811829;5319.468053194683;5345.1714984177515;5351.57187425006;5289.100852855015;5325.893482130355;5348.572114230862;5374.247605335247;5425.674459532431;4448.110377924412;4756.9286460703115;4791.017841342534;4793.760311984387;4798.328234047236;4833.226683730604;4845.127876982142;4866.926996095043;4881.389826271716;4891.608671306287;4696.906061878777;4769.308450274691;4769.713817170981;4778.498257682928;4808.903821923577;4761.0715910397485;4773.5226477352335;4777.498362671904;4778.139934811733;4784.760761961888;4700.811967521295;4715.882102947419;4731.858044258678;4739.431268247832;4743.335932969352;5224.895502089975;5247.212918062283;5261.4475480074425;5263.973680131575;5278.261043453919;5697.800576979786;5702.258706368187;5704.572157088235;5705.058665320217;5722.885542289173;5738.139279108125;5754.683492407916;5756.510696590794;5757.050086735683;5759.049756790125;5250.65870718402;5261.210818377236;5281.207818827206;5287.048331300326;5304.151335786294;5880.823835232971;5915.822525324247;5915.911261331084;5919.644821310735;5927.9407205928255;5592.105263157875;5592.217089607377;5641.576881733804;5658.971705141448;5663.178839068312;5680.744366503517;5681.9431805681415;5701.344345400249;5705;5772.2207501986695;5647.576431767634;5654.547636189095;5658.490735833795;5659.830205093854;5664.150377443417;5614.578906582023;5662.603617746719;5668.149777533321;5707.743151558107;5712.257406537124;4820.807167713322;4840.878978025577;4846.248831431134;4869.366982292279;4893.290472881412;4120.567340429212;4125.030617804813;4138.255114079434;4156.480439945007;4173.31140361843;4873.658843880965;4928.186849169919;4958;4986.152354099811;4996.325496058058;5765.423457654201;5846.386129456431;5857.7949771757785;5859.648421094748;5872.119182122716;4970.65205435616;4983.875403114951;4991.725455100004;5012.072766538202;5038.79844806211;5094.872628184325;5139;5150.304708864331;5170.45710200431;5190.039842629126;5398.865028374322;5433.212184233185;5441.5374693151525;5456.945430545803;5468.72656367188;5701.885962280814;5768.2501274834;5801.3038435388025;5856.975029369928;5861.648301101947;5428.7014214217015;5443.156310771837;5443.727813609383;5445.918311225414;5468.097763868917;5633.126865335879;5680.886382272414;5680.943190568041;5694.202811606296;5695.288088988877;5662.207290979349;5760.337561180518;5762.769489220552;5809.916944347874;5908.911366329423;5547.972260138674;5565.972170139124;5583.916241256303;5595.272614560244;5609.663420194802;5517.951589198039;5567.164925261243;5588.972055139699;5601.551875849841;5621.8594535136945;5375.602348352215;5381.381141168816;5395.757190926496;5437.293151890229;5447.591430642638;5536.363318218296;5541.224228607917;5595.160725891149;5606.943930560642;5669.886602268014;5443.727813609383;5454.072807622634;5467.152591348347;5469.972650136724;5471.534919531884 16:31:16 INFO - PID 18583 | |1;ext.html;670.2593634034392;718.2207305073995;741.2846603028079;1000.719798456432;1016;31585.526217106733;32453.188670283223;32493.025209243762;32572.837135814287;32620.347593048125;33488.47905532752;33701.494477582855;33719.325613487774;33835.66164338356;33956.15109622261;6677.732890684367;6780.796576102724;6857.279985601503;6986.231514533397;6987.2663370346145;6791.098492422129;6823.488238382116;6865.519413641047;6902.516823822334;6904.067950826649;6786.049953006583;6856.211535673411;6880.965595172042;6895.241523432418;6896.586204827701;6857.485688573352;6858.211305699859;6893.931060689379;6912.170539535263;6916.965415172917;6755.054292399068;6802.455803535705;6814.352636499525;6842.213145488283;6845.418139458152;30482.847585762152;30598.388032239454;30602.08193754191;30803.845980770177;30805.537916931265;3019;3024.5311976643657;3050.4051709916575;3061.785675002751;3072.0476652237653;21913.67129493043;21992.78007219923;22011.669824952638;22101.226457073924;22188.778112218995;3138.0899539133625;3154.6056742907135;3159.8420078996187;3167.6990685884803;3208.566843476124;139385.303073485;139728;140234;143552;146852.2657386717;37633.435498467545;37956.43065354022;37988.43017354742;38106.80946595305;38125;39395.80302098471;39437.605623943964;39627.40558891619;39641;39702.60297397047;10794.352338859693;10951.4524273786;10952.945235273774;12000.63998080059;12092.939535302443;8401.117882622359;8528.914710852812;8535.615897284637;8542.44474109181;8544.444611100384;12376.504939802488;12477.875221247852;12523.123381363399;12593.811092833615;12703.93648031754;5200.401953775364;5338.839834804962;5352.330958630171;5369.892602148013;5412.91880621791;882.2941646682629;912.056022017209;919.632147141149;923.2844545477309;943.8584212368063;20077.976607017838;20406.69389959152;21291.36125916225;21631;21741.934516220932;987.9654212102541;989.2382865193904;991.5438898106952;1015.4364327798143;1021.7649940513575;10784.514696838662;11336.716582085513;11382.487788049557;11399.145064120225;11411.25826821254;162448.18775906044;162611;162770;162969;163415;37954.240915181545;38049.2390152201;38148.61851381451;38217;38389;1204.4278967490548;1240.2682417373792;1248.6815861955142;1257.251935098615;1265.8417697787593;19638.705419419006;19748.40754777359;20312.695309570074;20902;21189.682154767997;26924;26952.326191844575;27066.864665676545;27073.864630676722;27081.322966925196;129878;129921.35039324743;130023;130904;131092;30151;30300.848495757382;30581.388372232876;30592.235194120323;30619;35823.26827707554;36151.27697445984;36623.633763663085;36699.44950825686;36907.815460922524;27365.45269094647;27751.30621734473;28306.575401368584;28328.716712832607;28954.7104528952;26558.86720566462;26884.731152688222;27185.72814271832;27380.45239095247;28604.14187574376;30736.231594210323;30835.84582077075;30883.536746948364;31050.68949310478;31075.223119422197;26109.73890261073;26196.8690156548;26768.33079173036;26872;27738.72261277442;21016.474588135417;21887.781122188575;22032.33902982913;22279;22810.42973925665 16:31:16 INFO - PID 18583 | |2;jquery.html;420.17226064652624;424.67207781088405;434.43523419554583;440.3109134204969;443.77145769928495;16591.83408165918;16904.83095169048;17222.880512766693;17454.389096381597;17621.55946101348;16768.32926682931;17025;18405.26378944844;19233.903830480864;19452.610947781035;5459.181122831567;5552.750126244318;5674.290713660793;5700.144978253254;5706.258186435778;5632.774689012455;5635.6618602883955;5668.489835914766;5676.318841738997;5678.34699009613;5474.315710536183;5574.916376254359;5615.9157612635845;5626.578006649497;5684.573656975723;5606.271184745978;5622.971885140589;5626.381098079208;5633.0987042073275;5688.516476099537;4919.335889654886;5074.543291103819;5083.262926875583;5114.565261952738;5122.052420302219;21782;22088.447788805246;22388.664170037464;22518.66222006671;22628.32115036535;1669.5241856071084;1706.6074802795426;1710.6493168900345;1715.5625315544457;1720.9311627534883;14704.411823527045;14789;15206.315715792816;15269.38922443101;15368.462103826312;1873.8875667459995;1929.170456703617;1939.1273926732886;1942.7183058456585;2090.143041353038;78847.21152788456;85724;88573;94423.52788236084;94811.0518894809;10988.285761425483;11381.544738210545;11393.088552915748;11439.428028598702;11448.94275528617;15870.285837137357;15889.205539722967;16004.279807408695;16009.359625615078;16015.599610009609;7263.2736726328;7577.431692623075;7602.353799927068;7633.2366763323225;7809;6692.732290708414;6737.753515599532;6785.93214067853;6840.042394064735;6886.10480637514;7082.822929426702;7086.964565177141;7089.645517724093;7098.60957647324;7203.639818009078;2086.76002259739;2106.8841213733085;2114.1754715660904;2120.8409369297055;2257.2912504994074;844.2528362399198;873.4671850171391;876.1763941894726;881.5636260051316;910.7677542226689;17064.829351706325;17074.060926649152;17257.56856078608;17441.825581744273;18005.279788808562;878.7451639024739;885.7077164535688;891.4116682989196;894.0924961164424;903.7830920579014;9324.254059675346;9728.659496917715;9752.21982241419;9770;9926.652567160114;340613;343769;345752;348403;351035;68105.65947170233;69733.30266697268;70348;70624;72043.6397818018;1034.3380236648702;1055.5883205549842;1069.2087854987253;1071.57672719277;1076.8923107689325;14534.273286335429;14722.190279534729;14746.262686865828;14849.183294918883;15280.15959122259;36102.45846312255;36261.81869090637;36351;37109.443358349105;37230.25539489249;43699.12601747883;44861.102777943604;45572;45636.08727825491;46386.76806615946;8020.558869262247;8148.429609927248;8303.294219991127;8333.791655208426;8421.473557932473;12329.938350308192;12528.498860045496;12650.873491265338;12656.557020504239;13073.673158171121;10759.892401076202;10944.671659850217;10988.725281867697;11008.889911100787;11366.147538934778;10456.372617642966;10486;10489.370637761758;10608.310459820086;10768;10728.624498142528;10848.294860834021;10909;11096.500657470271;11098.50056747432;7821;8003.719869804529;8127.268545830903;8158.510489370657;8257.133001034805;10634.840477393;10794.136469082612;10839.349639021684;10846.67459976202;11166.385848778395 16:31:16 INFO - PID 18583 | |3;mootools.html;1238.5726924211147;1293.2240655606638;1300.2458574027066;1312.3635037007052;1313.7044165062855;10108.393496390212;10527.684169474918;10532.157427405808;10587.15302775778;10813.783724325529;10524.894751052487;10703.625373111943;10728.78542429153;10729.927007299266;10732.19508536859;2137.3694760045823;2147.5490147069136;2164.0910817456706;2177.0638625391075;2183.5632873425297;2184.1045171479695;2226.065052677871;2238.2837492002564;2245.820334373246;2248.1344682297354;2212;2225.9888700556558;2246.5731511012855;2248.022110381981;2259.344790010903;2147.9033443495;2180.13884515617;2183.4213933307688;2192.48476607997;2197.4176843136584;2006.5084054406764;2137.845563395764;2187.1798075721604;2197.571473562656;2203.3610253026604;10271.435071071088;10291.691249262534;10319.277650564463;10361.222908281909;10378.532966016472;5570.944290557123;5690.4025077367105;5736.4550367715;5740.282464691913;5741;3286.4577344738327;3563.7149028077692;3590.299891521154;3612.6387361263664;3620.31214069326;1050.0811789684026;1056.2025670618712;1091.9727006824814;1097.1442275025413;1110.955561777536;15262.694746105126;15293.235338233155;15400.22998850053;15470.45853395137;15502.457413990456;4875.975620121877;4960.454350021495;5065.189569668835;5091.338126043591;5098.46466121052;10846;10857;10864.348139111678;10900.07349375312;10931.890681093088;5516.531094856902;5558.44415558449;5559.082751346064;5559.527440167551;5567.498925096761;4848.272759086165;4887.340209071801;4951.950480495221;4962.702237865739;5149.330587023663;3790.0903783092413;3877.84488620452;3900.239453306578;3986.9601303986587;4038.313486707208;1172.1033409441784;1187.1808452167977;1196.132803717298;1203.5967950736601;1206.9336186509827;676.2189670930084;697.2609034423527;698.2179958446573;705.5484489926451;719.8344380792447;5087.03346364197;5240.318758561362;5254.211868219798;5343.519083282523;5423.484768946943;537.223711736537;546.3089192171906;556.9805056823072;559.7089513453063;562.05013527139;3293.5883014623173;3479.7042251408916;3537.911552211215;3569.411047177187;3658.579263384692;12708.237505749685;13610.251436171106;13672.726545469035;13686.794698079537;13697.726045479034;13026.869731302566;13471.663208419672;13681.726365472834;13730.588082357544;13739.106958047894;7597.278258565428;7823.56970366624;7846.607669616496;7850.332721718718;7877.3304269136615;5519.9448005521035;5558.66648001105;5589.972050139723;5656.0667489865355;5683.204351390726;11518;11669;11742.70643233926;11745.588904388305;12006.579769708018;12084.577039803917;12193.207441516628;12338.75322493563;12345.69135771577;12439.067069969607;7284.745033923788;7461.477696561188;7494.5503269803985;7495.512791668524;7512.962435187789;9251.76870578241;9305.395149315273;9348.485833279236;9354.111359420844;9496.287778416508;7984.6806127754235;8064.314533264738;8087.191280872101;8164.428490005643;8174.141715119827;7574.394048475999;7639.312461878458;7641.923580764121;7745.883811742716;8183.6726530938095;6895.75864844728;6964.477664175309;6971.442284617117;6981.371676549135;7004;4882.170031094794;4920.892799120169;4950.45544990058;5010.473900240422;5163.586913046872;5128.256402821645;5133.537981581676;5192.324997750419;5214.400343960493;5316.813911513079 16:31:16 INFO - PID 18583 | |4;prototype.html;368.13488302489156;378.1774640157656;379.7398781834444;387.7053439386066;393.77358019138995;5486.286782718251;5533.142362933747;5547.751755854931;5585.385607583163;5592.189132575779;5371.167469042305;5447.809326673567;5449.237106805051;5467.6719396836215;5485.424030476803;4376.1247750449875;4379.693421460499;4381.123775244963;4387;4398.186335527922;4297.892552686192;4376.912461750763;4397.2304846651705;4413.411171978101;4418.491873434564;4330.484330484337;4337.804798784046;4347.174036932973;4347.304431290994;4362.694611377205;4371.125774845028;4374.671899607511;4376.19040477511;4386.188555117314;4392.297232442794;3939.881803545898;3983.621555952209;3985.880423587297;4011.1576568920564;4015.257177422157;5404.567634589223;5422.267993820823;5429.212764149176;5442.428545002757;5453.209284653703;5194.792208311663;5195.19474481456;5210.036143313499;5216.165413533817;5227.686338819645;5627.324721033502;5838.883222335572;5843.474087332118;5884.0585506318785;5895.4399332063385;4449.955500444987;4459.308807134899;4477.417935668343;4481.103779244132;4483.551644835523;5990.640561566276;6163.630182189083;6187.4740647045055;6216.658083805389;6308.526860485436;4352.129574085196;4357.368181613649;4363.912721745547;4371.30059190528;4381.058072514361;4405.185040767468;4444.688871779009;4445.066536027471;4451.443569553806;4457.420535330386;4944.25836124577;4963.939964914593;4971.279164521196;5016.2224855147515;5045.445001049881;5868.67722275279;5885.087811389241;5886.735096920649;5899.469047785634;5901.3508514063415;1621.1975072339267;1637.001429128231;1641.8111917129684;1644.21077882617;1644.6052947292565;1126.2622981946838;1150.8216226484908;1171.2211379432752;1173.530587764901;1187.922785018971;5094.2358646203365;5100.948990510047;5122.667026643257;5146.871328216825;5163.122269214243;5973.223480947449;6078.908816367758;6095.603785753912;6115.785947491817;6129.417705317987;5120.359955005624;5151.2530683050745;5157.716325602128;5163.122269214167;5166.328377310925;3173.0798068559857;3216.388886111631;3228.386606544749;3264.55928449661;3265.297960938362;5500.28496295479;5605.831825045255;5619.213310136584;5619.831405057855;5649.802256921071;6114.266288045463;6171.197744293213;6177.135201071854;6185.659788711574;6231.3145553989025;5418.972905135607;5597.916031259534;5606.775728970877;5608.439156084359;5630.380658127603;6025.457708806229;6071.848203794941;6076.908846367396;6077.4226448487325;6079.483243924316;5788.160716696139;5959.824663997696;6001.729922153426;6017.969910150421;6022.819315420545;5584.162375643686;5655.7454914528125;5655.830325090254;5660.349059858005;5675.716214189357;4150.875473735793;4178.8328466860985;4180.784184382283;4183.790810459525;4198.685098617555;5958.791442299499;6064.818055458343;6105.236845394325;6122.448979591858;6124.510039196764;5841.474267315962;5849.883002339844;5869.794557190648;5874.206982057539;5886.440788125121;5738.598298119258;5861.794837180678;5873.794417195378;5879.323877753942;5886.411358864079;5695.544356451391;5700.743466544099;5708.942910571007;5728.283964504437;5757.769689212552;5862.443067908542;5889.175515427758;5895.587308888336;5898.705064746831;5905;5613.803516877053;5689.487946084872;5727.68497732612;5745.425457454221;5747.827565173052 16:31:16 INFO - PID 18583 | |5;yui.html;743.126825979474;751.1174370115115;756.8826831841067;770.7610640701383;781.8709912864376;10939.890601093986;11401.315921044743;13395.79906301405;13981.860181398182;14141.787873181898;14756;15182.696346073071;15255.38978440861;15276.618084547892;15315.463958761446;827.896512935883;857.1942374168293;861.5821326656567;861.9310455163603;865.3855762408697;904.055262250946;904.5477261369315;906.1210625693067;906.2885634776702;907.3557773980482;939.3940908114262;942.8774259346276;944.3719926249071;946.0208684012049;946.5220063867737;943.8914524829629;945.5650400815599;951.0109486134412;951.5527701980059;951.7525443384701;693.9895901561481;695.408902432928;697.7976386847808;697.8883378659441;700.1213477086275;14035.368408421544;14367;14450.566483005421;14484.855151448455;14574.854251457456;14948.252587370587;15319.846801531954;15366.462173823862;15668.059916405053;15957.601059973478;11761.294322340687;11869.406529673483;11899.107566932515;11964.70088247792;11983.400829958468;2908.3310838507264;2918.6643535993207;2925.692802255775;2927.1072322941495;2935.4129174165037;69243.3075669242;69903.3009669902;70406;70667.2933270671;71678.64160679163;10755.946220269005;10891.618793342195;10950.945245273722;11014.229003969645;11066.446677666085;19550.902245488967;19838.504037398892;21572;22100.33698989033;22393;5814.273215848019;6011.969940150271;6092.634441933409;6142.078688196717;6148.631082134997;2789.8884044638394;2872.8707208175683;2876.956845647317;2882.4811533924094;2886.581445690363;3554.8933531993566;3593.443016332473;3605.6574625410544;3629.8366573503727;3736.5889752127246;735.6505659811546;748.3788455581854;751.549070557661;755.1844008470838;757.238974830292;554.9130652742602;575.65748379714;580.1703563903658;593.9287285525678;616.0789619518848;9843.704688859345;10056.245781566411;10270.486475676187;10877.456127193609;10974.176936729777;581.7324030945813;590.3270271890049;590.583638534832;595.8986972214734;610.7862248213179;4293.119910418357;4549.608614455404;4555.043440877453;4677.462091859412;4704.858854234379;60882.39117608856;61640;61768.44084032458;61812;64146.679266604304;55960.44039559552;58288.70855645695;58595.707021465474;58788.412115879146;58941;49996.250431200875;50821.74589127031;51293.7435312821;51325.48674513207;53442.465575344526;9586.760330991781;9696;9770.169535589555;9771.853422198816;10003.899961000297;25907.481850363263;26633.866830665724;26721.33196670099;26843;26846.59730104011;31396;31978.840105800253;32069.358612827145;32754;33039;11911;11993.40032998364;12032.217905836093;12148.635540933787;12236.204646698292;14496.637584060483;15262.618434539225;15576.84423155754;15932.362705492114;16055.678886421972;13365.331733413484;13635.522756703467;14421.855781442471;14896.925515372353;15167.620809479851;13018.674533136747;13139.343032848128;14816.254910171008;15276.77084843706;15277;13743.244121573409;13904.165750055028;13940.233287169303;14225;14467.710645787236;9690.563924623268;9869.309148359545;9972.451515166735;10158.746031349276;10339.327943683636;10882.769032348508;11572.826407603725;11603.303801771921;11753.294802311888;11764.647060588197 16:31:16 INFO - PID 18583 | __end_tp_report 16:31:16 INFO - PID 18583 | __start_cc_report 16:31:16 INFO - PID 18583 | _x_x_mozilla_cycle_collect,362 16:31:16 INFO - PID 18583 | __end_cc_report 16:31:16 INFO - PID 18583 | __startTimestamp1494718276831__endTimestamp 16:31:16 INFO - PID 18583 | 16:31:16 INFO - PID 18583 | ------- Summary: start ------- 16:31:16 INFO - PID 18583 | Number of tests: 6 16:31:16 INFO - PID 18583 | 16:31:16 INFO - PID 18583 | [#0] dojo.html Cycles:165 Average:5259.72 Median:5441.54 stddev:606.11 (11.1%) stddev-sans-first:575.34 16:31:16 INFO - PID 18583 | Values: 2758.7 2769.1 2782.9 2802.3 2805.6 5276.8 5314.3 5319.5 5345.2 5351.6 5289.1 5325.9 5348.6 5374.2 5425.7 4448.1 4756.9 4791.0 4793.8 4798.3 4833.2 4845.1 4866.9 4881.4 4891.6 4696.9 4769.3 4769.7 4778.5 4808.9 4761.1 4773.5 4777.5 4778.1 4784.8 4700.8 4715.9 4731.9 4739.4 4743.3 5224.9 5247.2 5261.4 5264.0 5278.3 5697.8 5702.3 5704.6 5705.1 5722.9 5738.1 5754.7 5756.5 5757.1 5759.0 5250.7 5261.2 5281.2 5287.0 5304.2 5880.8 5915.8 5915.9 5919.6 5927.9 5592.1 5592.2 5641.6 5659.0 5663.2 5680.7 5681.9 5701.3 5705.0 5772.2 5647.6 5654.5 5658.5 5659.8 5664.2 5614.6 5662.6 5668.1 5707.7 5712.3 4820.8 4840.9 4846.2 4869.4 4893.3 4120.6 4125.0 4138.3 4156.5 4173.3 4873.7 4928.2 4958.0 4986.2 4996.3 5765.4 5846.4 5857.8 5859.6 5872.1 4970.7 4983.9 4991.7 5012.1 5038.8 5094.9 5139.0 5150.3 5170.5 5190.0 5398.9 5433.2 5441.5 5456.9 5468.7 5701.9 5768.3 5801.3 5857.0 5861.6 5428.7 5443.2 5443.7 5445.9 5468.1 5633.1 5680.9 5680.9 5694.2 5695.3 5662.2 5760.3 5762.8 5809.9 5908.9 5548.0 5566.0 5583.9 5595.3 5609.7 5518.0 5567.2 5589.0 5601.6 5621.9 5375.6 5381.4 5395.8 5437.3 5447.6 5536.4 5541.2 5595.2 5606.9 5669.9 5443.7 5454.1 5467.2 5470.0 5471.5 16:31:16 INFO - PID 18583 | 16:31:16 INFO - PID 18583 | [#1] ext.html Cycles:180 Average:28708.83 Median:16845.52 stddev:37514.48 (222.7%) stddev-sans-first:37560.63 16:31:16 INFO - PID 18583 | Values: 670.3 718.2 741.3 1000.7 1016.0 31585.5 32453.2 32493.0 32572.8 32620.3 33488.5 33701.5 33719.3 33835.7 33956.2 6677.7 6780.8 6857.3 6986.2 6987.3 6791.1 6823.5 6865.5 6902.5 6904.1 6786.0 6856.2 6881.0 6895.2 6896.6 6857.5 6858.2 6893.9 6912.2 6917.0 6755.1 6802.5 6814.4 6842.2 6845.4 30482.8 30598.4 30602.1 30803.8 30805.5 3019.0 3024.5 3050.4 3061.8 3072.0 21913.7 21992.8 22011.7 22101.2 22188.8 3138.1 3154.6 3159.8 3167.7 3208.6 139385.3 139728.0 140234.0 143552.0 146852.3 37633.4 37956.4 37988.4 38106.8 38125.0 39395.8 39437.6 39627.4 39641.0 39702.6 10794.4 10951.5 10952.9 12000.6 12092.9 8401.1 8528.9 8535.6 8542.4 8544.4 12376.5 12477.9 12523.1 12593.8 12703.9 5200.4 5338.8 5352.3 5369.9 5412.9 882.3 912.1 919.6 923.3 943.9 20078.0 20406.7 21291.4 21631.0 21741.9 988.0 989.2 991.5 1015.4 1021.8 10784.5 11336.7 11382.5 11399.1 11411.3 162448.2 162611.0 162770.0 162969.0 163415.0 37954.2 38049.2 38148.6 38217.0 38389.0 1204.4 1240.3 1248.7 1257.3 1265.8 19638.7 19748.4 20312.7 20902.0 21189.7 26924.0 26952.3 27066.9 27073.9 27081.3 129878.0 129921.4 130023.0 130904.0 131092.0 30151.0 30300.8 30581.4 30592.2 30619.0 35823.3 36151.3 36623.6 36699.4 36907.8 27365.5 27751.3 28306.6 28328.7 28954.7 26558.9 26884.7 27185.7 27380.5 28604.1 30736.2 30835.8 30883.5 31050.7 31075.2 26109.7 26196.9 26768.3 26872.0 27738.7 21016.5 21887.8 22032.3 22279.0 22810.4 16:31:16 INFO - PID 18583 | 16:31:16 INFO - PID 18583 | [#2] jquery.html Cycles:180 Average:23853.15 Median:36182.14 stddev:57604.83 (159.2%) stddev-sans-first:57739.56 16:31:16 INFO - PID 18583 | Values: 420.2 424.7 434.4 440.3 443.8 16591.8 16904.8 17222.9 17454.4 17621.6 16768.3 17025.0 18405.3 19233.9 19452.6 5459.2 5552.8 5674.3 5700.1 5706.3 5632.8 5635.7 5668.5 5676.3 5678.3 5474.3 5574.9 5615.9 5626.6 5684.6 5606.3 5623.0 5626.4 5633.1 5688.5 4919.3 5074.5 5083.3 5114.6 5122.1 21782.0 22088.4 22388.7 22518.7 22628.3 1669.5 1706.6 1710.6 1715.6 1720.9 14704.4 14789.0 15206.3 15269.4 15368.5 1873.9 1929.2 1939.1 1942.7 2090.1 78847.2 85724.0 88573.0 94423.5 94811.1 10988.3 11381.5 11393.1 11439.4 11448.9 15870.3 15889.2 16004.3 16009.4 16015.6 7263.3 7577.4 7602.4 7633.2 7809.0 6692.7 6737.8 6785.9 6840.0 6886.1 7082.8 7087.0 7089.6 7098.6 7203.6 2086.8 2106.9 2114.2 2120.8 2257.3 844.3 873.5 876.2 881.6 910.8 17064.8 17074.1 17257.6 17441.8 18005.3 878.7 885.7 891.4 894.1 903.8 9324.3 9728.7 9752.2 9770.0 9926.7 340613.0 343769.0 345752.0 348403.0 351035.0 68105.7 69733.3 70348.0 70624.0 72043.6 1034.3 1055.6 1069.2 1071.6 1076.9 14534.3 14722.2 14746.3 14849.2 15280.2 36102.5 36261.8 36351.0 37109.4 37230.3 43699.1 44861.1 45572.0 45636.1 46386.8 8020.6 8148.4 8303.3 8333.8 8421.5 12329.9 12528.5 12650.9 12656.6 13073.7 10759.9 10944.7 10988.7 11008.9 11366.1 10456.4 10486.0 10489.4 10608.3 10768.0 10728.6 10848.3 10909.0 11096.5 11098.5 7821.0 8003.7 8127.3 8158.5 8257.1 10634.8 10794.1 10839.3 10846.7 11166.4 16:31:16 INFO - PID 18583 | 16:31:16 INFO - PID 18583 | [#3] mootools.html Cycles:180 Average:6256.66 Median:3579.86 stddev:4100.92 (114.6%) stddev-sans-first:4095.09 16:31:16 INFO - PID 18583 | Values: 1238.6 1293.2 1300.2 1312.4 1313.7 10108.4 10527.7 10532.2 10587.2 10813.8 10524.9 10703.6 10728.8 10729.9 10732.2 2137.4 2147.5 2164.1 2177.1 2183.6 2184.1 2226.1 2238.3 2245.8 2248.1 2212.0 2226.0 2246.6 2248.0 2259.3 2147.9 2180.1 2183.4 2192.5 2197.4 2006.5 2137.8 2187.2 2197.6 2203.4 10271.4 10291.7 10319.3 10361.2 10378.5 5570.9 5690.4 5736.5 5740.3 5741.0 3286.5 3563.7 3590.3 3612.6 3620.3 1050.1 1056.2 1092.0 1097.1 1111.0 15262.7 15293.2 15400.2 15470.5 15502.5 4876.0 4960.5 5065.2 5091.3 5098.5 10846.0 10857.0 10864.3 10900.1 10931.9 5516.5 5558.4 5559.1 5559.5 5567.5 4848.3 4887.3 4952.0 4962.7 5149.3 3790.1 3877.8 3900.2 3987.0 4038.3 1172.1 1187.2 1196.1 1203.6 1206.9 676.2 697.3 698.2 705.5 719.8 5087.0 5240.3 5254.2 5343.5 5423.5 537.2 546.3 557.0 559.7 562.1 3293.6 3479.7 3537.9 3569.4 3658.6 12708.2 13610.3 13672.7 13686.8 13697.7 13026.9 13471.7 13681.7 13730.6 13739.1 7597.3 7823.6 7846.6 7850.3 7877.3 5519.9 5558.7 5590.0 5656.1 5683.2 11518.0 11669.0 11742.7 11745.6 12006.6 12084.6 12193.2 12338.8 12345.7 12439.1 7284.7 7461.5 7494.6 7495.5 7513.0 9251.8 9305.4 9348.5 9354.1 9496.3 7984.7 8064.3 8087.2 8164.4 8174.1 7574.4 7639.3 7641.9 7745.9 8183.7 6895.8 6964.5 6971.4 6981.4 7004.0 4882.2 4920.9 4950.5 5010.5 5163.6 5128.3 5133.5 5192.3 5214.4 5316.8 16:31:16 INFO - PID 18583 | 16:31:16 INFO - PID 18583 | [#4] prototype.html Cycles:180 Average:4897.72 Median:5445.12 stddev:1380.17 (25.3%) stddev-sans-first:1341.51 16:31:16 INFO - PID 18583 | Values: 368.1 378.2 379.7 387.7 393.8 5486.3 5533.1 5547.8 5585.4 5592.2 5371.2 5447.8 5449.2 5467.7 5485.4 4376.1 4379.7 4381.1 4387.0 4398.2 4297.9 4376.9 4397.2 4413.4 4418.5 4330.5 4337.8 4347.2 4347.3 4362.7 4371.1 4374.7 4376.2 4386.2 4392.3 3939.9 3983.6 3985.9 4011.2 4015.3 5404.6 5422.3 5429.2 5442.4 5453.2 5194.8 5195.2 5210.0 5216.2 5227.7 5627.3 5838.9 5843.5 5884.1 5895.4 4450.0 4459.3 4477.4 4481.1 4483.6 5990.6 6163.6 6187.5 6216.7 6308.5 4352.1 4357.4 4363.9 4371.3 4381.1 4405.2 4444.7 4445.1 4451.4 4457.4 4944.3 4963.9 4971.3 5016.2 5045.4 5868.7 5885.1 5886.7 5899.5 5901.4 1621.2 1637.0 1641.8 1644.2 1644.6 1126.3 1150.8 1171.2 1173.5 1187.9 5094.2 5100.9 5122.7 5146.9 5163.1 5973.2 6078.9 6095.6 6115.8 6129.4 5120.4 5151.3 5157.7 5163.1 5166.3 3173.1 3216.4 3228.4 3264.6 3265.3 5500.3 5605.8 5619.2 5619.8 5649.8 6114.3 6171.2 6177.1 6185.7 6231.3 5419.0 5597.9 5606.8 5608.4 5630.4 6025.5 6071.8 6076.9 6077.4 6079.5 5788.2 5959.8 6001.7 6018.0 6022.8 5584.2 5655.7 5655.8 5660.3 5675.7 4150.9 4178.8 4180.8 4183.8 4198.7 5958.8 6064.8 6105.2 6122.4 6124.5 5841.5 5849.9 5869.8 5874.2 5886.4 5738.6 5861.8 5873.8 5879.3 5886.4 5695.5 5700.7 5708.9 5728.3 5757.8 5862.4 5889.2 5895.6 5898.7 5905.0 5613.8 5689.5 5727.7 5745.4 5747.8 16:31:16 INFO - PID 18583 | 16:31:16 INFO - PID 18583 | [#5] yui.html Cycles:180 Average:15038.05 Median:32896.50 stddev:17924.10 (54.5%) stddev-sans-first:17942.23 16:31:16 INFO - PID 18583 | Values: 743.1 751.1 756.9 770.8 781.9 10939.9 11401.3 13395.8 13981.9 14141.8 14756.0 15182.7 15255.4 15276.6 15315.5 827.9 857.2 861.6 861.9 865.4 904.1 904.5 906.1 906.3 907.4 939.4 942.9 944.4 946.0 946.5 943.9 945.6 951.0 951.6 951.8 694.0 695.4 697.8 697.9 700.1 14035.4 14367.0 14450.6 14484.9 14574.9 14948.3 15319.8 15366.5 15668.1 15957.6 11761.3 11869.4 11899.1 11964.7 11983.4 2908.3 2918.7 2925.7 2927.1 2935.4 69243.3 69903.3 70406.0 70667.3 71678.6 10755.9 10891.6 10950.9 11014.2 11066.4 19550.9 19838.5 21572.0 22100.3 22393.0 5814.3 6012.0 6092.6 6142.1 6148.6 2789.9 2872.9 2877.0 2882.5 2886.6 3554.9 3593.4 3605.7 3629.8 3736.6 735.7 748.4 751.5 755.2 757.2 554.9 575.7 580.2 593.9 616.1 9843.7 10056.2 10270.5 10877.5 10974.2 581.7 590.3 590.6 595.9 610.8 4293.1 4549.6 4555.0 4677.5 4704.9 60882.4 61640.0 61768.4 61812.0 64146.7 55960.4 58288.7 58595.7 58788.4 58941.0 49996.3 50821.7 51293.7 51325.5 53442.5 9586.8 9696.0 9770.2 9771.9 10003.9 25907.5 26633.9 26721.3 26843.0 26846.6 31396.0 31978.8 32069.4 32754.0 33039.0 11911.0 11993.4 12032.2 12148.6 12236.2 14496.6 15262.6 15576.8 15932.4 16055.7 13365.3 13635.5 14421.9 14896.9 15167.6 13018.7 13139.3 14816.3 15276.8 15277.0 13743.2 13904.2 13940.2 14225.0 14467.7 9690.6 9869.3 9972.5 10158.7 10339.3 10882.8 11572.8 11603.3 11753.3 11764.6 16:31:16 INFO - PID 18583 | -------- Summary: end -------- 16:31:16 INFO - PID 18583 | 16:31:17 INFO - TEST-INFO | 18583: exit 0 16:31:17 INFO - TEST-OK | dromaeo_css | took 1119817ms 16:31:17 INFO - TEST-START | kraken 16:31:17 INFO - operating with platform_type : linux_ 16:31:17 INFO - Initialising browser for kraken test... 16:31:17 INFO - TEST-INFO | started process 19001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5JJE0K/profile http://localhost:34559/getInfo.html) 16:31:21 INFO - PID 19001 | __metrics Screen width/height:1600/1200 16:31:21 INFO - PID 19001 | colorDepth:24 16:31:21 INFO - PID 19001 | Browser inner width/height: 1024/695 16:31:21 INFO - PID 19001 | __metrics 16:31:23 INFO - TEST-INFO | 19001: exit 0 16:31:23 INFO - Browser initialized. 16:31:23 INFO - Running cycle 1/1 for kraken test... 16:31:23 INFO - TEST-INFO | started process 19169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5JJE0K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:35 INFO - PID 19169 | RSS: Main: 157884416 16:31:35 INFO - PID 19169 | 16:31:38 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34559/tests/kraken/driver.html?testName=audio-beat-detection) 16:31:39 INFO - PID 19169 | RSS: Main: 163680256 16:31:39 INFO - PID 19169 | 16:31:41 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34559/tests/kraken/driver.html?testName=audio-dft) 16:31:42 INFO - PID 19169 | RSS: Main: 162140160 16:31:42 INFO - PID 19169 | 16:31:45 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34559/tests/kraken/driver.html?testName=audio-fft) 16:31:45 INFO - PID 19169 | RSS: Main: 158932992 16:31:45 INFO - PID 19169 | 16:31:48 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34559/tests/kraken/driver.html?testName=audio-oscillator) 16:31:48 INFO - PID 19169 | RSS: Main: 159604736 16:31:48 INFO - PID 19169 | 16:31:50 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34559/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:31:51 INFO - PID 19169 | RSS: Main: 159707136 16:31:51 INFO - PID 19169 | 16:31:54 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34559/tests/kraken/driver.html?testName=imaging-darkroom) 16:31:55 INFO - PID 19169 | RSS: Main: 164315136 16:31:55 INFO - PID 19169 | 16:31:58 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34559/tests/kraken/driver.html?testName=imaging-desaturate) 16:31:59 INFO - PID 19169 | RSS: Main: 163442688 16:31:59 INFO - PID 19169 | 16:32:02 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34559/tests/kraken/driver.html?testName=json-parse-financial) 16:32:02 INFO - PID 19169 | RSS: Main: 164286464 16:32:02 INFO - PID 19169 | 16:32:04 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34559/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:32:05 INFO - PID 19169 | RSS: Main: 164511744 16:32:05 INFO - PID 19169 | 16:32:06 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34559/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:32:07 INFO - PID 19169 | RSS: Main: 164405248 16:32:07 INFO - PID 19169 | 16:32:09 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34559/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:32:10 INFO - PID 19169 | RSS: Main: 164511744 16:32:10 INFO - PID 19169 | 16:32:12 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34559/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:32:13 INFO - PID 19169 | RSS: Main: 164491264 16:32:13 INFO - PID 19169 | 16:32:16 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34559/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:32:17 INFO - PID 19169 | RSS: Main: 164462592 16:32:17 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | Cycle 1(1): loaded http://localhost:34559/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34559/tests/kraken/driver.html?testName=ai-astar) 16:32:19 INFO - PID 19169 | RSS: Main: 165994496 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | __start_tp_report 16:32:19 INFO - PID 19169 | _x_x_mozilla_page_load 16:32:19 INFO - PID 19169 | _x_x_mozilla_page_load_details 16:32:19 INFO - PID 19169 | |i|pagename|runs| 16:32:19 INFO - PID 19169 | |0;ai-astar;103;112;113;111;111;110;113;113;113;113 16:32:19 INFO - PID 19169 | |1;audio-beat-detection;154;129;124;180;131;122;126;125;148;129 16:32:19 INFO - PID 19169 | |2;audio-dft;165;164;167;165;170;173;170;163;164;163 16:32:19 INFO - PID 19169 | |3;audio-fft;78;76;76;121;76;74;75;75;95;75 16:32:19 INFO - PID 19169 | |4;audio-oscillator;83;83;112;83;84;84;96;83;83;102 16:32:19 INFO - PID 19169 | |5;imaging-gaussian-blur;115;114;114;114;114;115;115;117;114;114 16:32:19 INFO - PID 19169 | |6;imaging-darkroom;153;155;153;153;152;153;152;152;152;150 16:32:19 INFO - PID 19169 | |7;imaging-desaturate;95;95;94;95;94;94;94;95;95;95 16:32:19 INFO - PID 19169 | |8;json-parse-financial;57;56;57;56;58;61;57;58;56;57 16:32:19 INFO - PID 19169 | |9;json-stringify-tinderbox;56;60;56;55;55;56;56;56;56;56 16:32:19 INFO - PID 19169 | |10;stanford-crypto-aes;83;82;84;92;82;82;83;84;85;84 16:32:19 INFO - PID 19169 | |11;stanford-crypto-ccm;145;128;141;141;142;130;130;133;178;135 16:32:19 INFO - PID 19169 | |12;stanford-crypto-pbkdf2;188;199;197;193;195;184;195;192;191;191 16:32:19 INFO - PID 19169 | |13;stanford-crypto-sha256-iterative;89;73;76;78;76;73;72;75;76;73 16:32:19 INFO - PID 19169 | __end_tp_report 16:32:19 INFO - PID 19169 | __start_cc_report 16:32:19 INFO - PID 19169 | _x_x_mozilla_cycle_collect,838 16:32:19 INFO - PID 19169 | __end_cc_report 16:32:19 INFO - PID 19169 | __startTimestamp1494718339592__endTimestamp 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | ------- Summary: start ------- 16:32:19 INFO - PID 19169 | Number of tests: 14 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:3.08 (2.7%) stddev-sans-first:1.17 16:32:19 INFO - PID 19169 | Values: 103.0 112.0 113.0 111.0 111.0 110.0 113.0 113.0 113.0 113.0 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:130.00 stddev:18.50 (14.2%) stddev-sans-first:18.55 16:32:19 INFO - PID 19169 | Values: 154.0 129.0 124.0 180.0 131.0 122.0 126.0 125.0 148.0 129.0 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.00 stddev:3.47 (2.1%) stddev-sans-first:3.64 16:32:19 INFO - PID 19169 | Values: 165.0 164.0 167.0 165.0 170.0 173.0 170.0 163.0 164.0 163.0 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:15.00 (19.7%) stddev-sans-first:15.84 16:32:19 INFO - PID 19169 | Values: 78.0 76.0 76.0 121.0 76.0 74.0 75.0 75.0 95.0 75.0 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:83.00 stddev:10.41 (12.5%) stddev-sans-first:10.79 16:32:19 INFO - PID 19169 | Values: 83.0 83.0 112.0 83.0 84.0 84.0 96.0 83.0 83.0 102.0 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:0.97 (0.8%) stddev-sans-first:1.01 16:32:19 INFO - PID 19169 | Values: 115.0 114.0 114.0 114.0 114.0 115.0 115.0 117.0 114.0 114.0 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#6] imaging-darkroom Cycles:10 Average:152.50 Median:153.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 16:32:19 INFO - PID 19169 | Values: 153.0 155.0 153.0 153.0 152.0 153.0 152.0 152.0 152.0 150.0 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:32:19 INFO - PID 19169 | Values: 95.0 95.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.00 stddev:1.49 (2.6%) stddev-sans-first:1.58 16:32:19 INFO - PID 19169 | Values: 57.0 56.0 57.0 56.0 58.0 61.0 57.0 58.0 56.0 57.0 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:1.40 (2.5%) stddev-sans-first:1.48 16:32:19 INFO - PID 19169 | Values: 56.0 60.0 56.0 55.0 55.0 56.0 56.0 56.0 56.0 56.0 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:84.00 stddev:2.96 (3.5%) stddev-sans-first:3.11 16:32:19 INFO - PID 19169 | Values: 83.0 82.0 84.0 92.0 82.0 82.0 83.0 84.0 85.0 84.0 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:141.00 stddev:14.50 (10.3%) stddev-sans-first:15.28 16:32:19 INFO - PID 19169 | Values: 145.0 128.0 141.0 141.0 142.0 130.0 130.0 133.0 178.0 135.0 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.50 Median:194.00 stddev:4.38 (2.3%) stddev-sans-first:4.33 16:32:19 INFO - PID 19169 | Values: 188.0 199.0 197.0 193.0 195.0 184.0 195.0 192.0 191.0 191.0 16:32:19 INFO - PID 19169 | 16:32:19 INFO - PID 19169 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.10 Median:76.00 stddev:4.91 (6.5%) stddev-sans-first:2.00 16:32:19 INFO - PID 19169 | Values: 89.0 73.0 76.0 78.0 76.0 73.0 72.0 75.0 76.0 73.0 16:32:19 INFO - PID 19169 | -------- Summary: end -------- 16:32:19 INFO - PID 19169 | 16:32:20 INFO - TEST-INFO | 19169: exit 0 16:32:20 INFO - TEST-OK | kraken | took 63253ms 16:32:20 INFO - SUITE-END | took 1183s 16:32:21 INFO - Completed test suite (00:19:43) 16:32:21 INFO - javascript benchmark 16:32:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6704.692996544909, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2758.737919897609, 2769.0862015534876, 2782.888684452622, 2802.341449759306, 2805.593188987596, 5276.7889284428675, 5314.309139811829, 5319.468053194683, 5345.1714984177515, 5351.57187425006, 5289.100852855015, 5325.893482130355, 5348.572114230862, 5374.247605335247, 5425.674459532431, 4448.110377924412, 4756.9286460703115, 4791.017841342534, 4793.760311984387, 4798.328234047236, 4833.226683730604, 4845.127876982142, 4866.926996095043, 4881.389826271716, 4891.608671306287, 4696.906061878777, 4769.308450274691, 4769.713817170981, 4778.498257682928, 4808.903821923577, 4761.0715910397485, 4773.5226477352335, 4777.498362671904, 4778.139934811733, 4784.760761961888, 4700.811967521295, 4715.882102947419, 4731.858044258678, 4739.431268247832, 4743.335932969352, 5224.895502089975, 5247.212918062283, 5261.4475480074425, 5263.973680131575, 5278.261043453919, 5697.800576979786, 5702.258706368187, 5704.572157088235, 5705.058665320217, 5722.885542289173, 5738.139279108125, 5754.683492407916, 5756.510696590794, 5757.050086735683, 5759.049756790125, 5250.65870718402, 5261.210818377236, 5281.207818827206, 5287.048331300326, 5304.151335786294, 5880.823835232971, 5915.822525324247, 5915.911261331084, 5919.644821310735, 5927.9407205928255, 5592.105263157875, 5592.217089607377, 5641.576881733804, 5658.971705141448, 5663.178839068312, 5680.744366503517, 5681.9431805681415, 5701.344345400249, 5705.0, 5772.2207501986695, 5647.576431767634, 5654.547636189095, 5658.490735833795, 5659.830205093854, 5664.150377443417, 5614.578906582023, 5662.603617746719, 5668.149777533321, 5707.743151558107, 5712.257406537124, 4820.807167713322, 4840.878978025577, 4846.248831431134, 4869.366982292279, 4893.290472881412, 4120.567340429212, 4125.030617804813, 4138.255114079434, 4156.480439945007, 4173.31140361843, 4873.658843880965, 4928.186849169919, 4958.0, 4986.152354099811, 4996.325496058058, 5765.423457654201, 5846.386129456431, 5857.7949771757785, 5859.648421094748, 5872.119182122716, 4970.65205435616, 4983.875403114951, 4991.725455100004, 5012.072766538202, 5038.79844806211, 5094.872628184325, 5139.0, 5150.304708864331, 5170.45710200431, 5190.039842629126, 5398.865028374322, 5433.212184233185, 5441.5374693151525, 5456.945430545803, 5468.72656367188, 5701.885962280814, 5768.2501274834, 5801.3038435388025, 5856.975029369928, 5861.648301101947, 5428.7014214217015, 5443.156310771837, 5443.727813609383, 5445.918311225414, 5468.097763868917, 5633.126865335879, 5680.886382272414, 5680.943190568041, 5694.202811606296, 5695.288088988877, 5662.207290979349, 5760.337561180518, 5762.769489220552, 5809.916944347874, 5908.911366329423, 5547.972260138674, 5565.972170139124, 5583.916241256303, 5595.272614560244, 5609.663420194802, 5517.951589198039, 5567.164925261243, 5588.972055139699, 5601.551875849841, 5621.8594535136945, 5375.602348352215, 5381.381141168816, 5395.757190926496, 5437.293151890229, 5447.591430642638, 5536.363318218296, 5541.224228607917, 5595.160725891149, 5606.943930560642, 5669.886602268014, 5443.727813609383, 5454.072807622634, 5467.152591348347, 5469.972650136724, 5471.534919531884], "value": 5216.228641742911, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.2593634034392, 718.2207305073995, 741.2846603028079, 1000.719798456432, 1016.0, 31585.526217106733, 32453.188670283223, 32493.025209243762, 32572.837135814287, 32620.347593048125, 33488.47905532752, 33701.494477582855, 33719.325613487774, 33835.66164338356, 33956.15109622261, 6677.732890684367, 6780.796576102724, 6857.279985601503, 6986.231514533397, 6987.2663370346145, 6791.098492422129, 6823.488238382116, 6865.519413641047, 6902.516823822334, 6904.067950826649, 6786.049953006583, 6856.211535673411, 6880.965595172042, 6895.241523432418, 6896.586204827701, 6857.485688573352, 6858.211305699859, 6893.931060689379, 6912.170539535263, 6916.965415172917, 6755.054292399068, 6802.455803535705, 6814.352636499525, 6842.213145488283, 6845.418139458152, 30482.847585762152, 30598.388032239454, 30602.08193754191, 30803.845980770177, 30805.537916931265, 3019.0, 3024.5311976643657, 3050.4051709916575, 3061.785675002751, 3072.0476652237653, 21913.67129493043, 21992.78007219923, 22011.669824952638, 22101.226457073924, 22188.778112218995, 3138.0899539133625, 3154.6056742907135, 3159.8420078996187, 3167.6990685884803, 3208.566843476124, 139385.303073485, 139728.0, 140234.0, 143552.0, 146852.2657386717, 37633.435498467545, 37956.43065354022, 37988.43017354742, 38106.80946595305, 38125.0, 39395.80302098471, 39437.605623943964, 39627.40558891619, 39641.0, 39702.60297397047, 10794.352338859693, 10951.4524273786, 10952.945235273774, 12000.63998080059, 12092.939535302443, 8401.117882622359, 8528.914710852812, 8535.615897284637, 8542.44474109181, 8544.444611100384, 12376.504939802488, 12477.875221247852, 12523.123381363399, 12593.811092833615, 12703.93648031754, 5200.401953775364, 5338.839834804962, 5352.330958630171, 5369.892602148013, 5412.91880621791, 882.2941646682629, 912.056022017209, 919.632147141149, 923.2844545477309, 943.8584212368063, 20077.976607017838, 20406.69389959152, 21291.36125916225, 21631.0, 21741.934516220932, 987.9654212102541, 989.2382865193904, 991.5438898106952, 1015.4364327798143, 1021.7649940513575, 10784.514696838662, 11336.716582085513, 11382.487788049557, 11399.145064120225, 11411.25826821254, 162448.18775906044, 162611.0, 162770.0, 162969.0, 163415.0, 37954.240915181545, 38049.2390152201, 38148.61851381451, 38217.0, 38389.0, 1204.4278967490548, 1240.2682417373792, 1248.6815861955142, 1257.251935098615, 1265.8417697787593, 19638.705419419006, 19748.40754777359, 20312.695309570074, 20902.0, 21189.682154767997, 26924.0, 26952.326191844575, 27066.864665676545, 27073.864630676722, 27081.322966925196, 129878.0, 129921.35039324743, 130023.0, 130904.0, 131092.0, 30151.0, 30300.848495757382, 30581.388372232876, 30592.235194120323, 30619.0, 35823.26827707554, 36151.27697445984, 36623.633763663085, 36699.44950825686, 36907.815460922524, 27365.45269094647, 27751.30621734473, 28306.575401368584, 28328.716712832607, 28954.7104528952, 26558.86720566462, 26884.731152688222, 27185.72814271832, 27380.45239095247, 28604.14187574376, 30736.231594210323, 30835.84582077075, 30883.536746948364, 31050.68949310478, 31075.223119422197, 26109.73890261073, 26196.8690156548, 26768.33079173036, 26872.0, 27738.72261277442, 21016.474588135417, 21887.781122188575, 22032.33902982913, 22279.0, 22810.42973925665], "value": 14092.131297993923, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.17226064652624, 424.67207781088405, 434.43523419554583, 440.3109134204969, 443.77145769928495, 16591.83408165918, 16904.83095169048, 17222.880512766693, 17454.389096381597, 17621.55946101348, 16768.32926682931, 17025.0, 18405.26378944844, 19233.903830480864, 19452.610947781035, 5459.181122831567, 5552.750126244318, 5674.290713660793, 5700.144978253254, 5706.258186435778, 5632.774689012455, 5635.6618602883955, 5668.489835914766, 5676.318841738997, 5678.34699009613, 5474.315710536183, 5574.916376254359, 5615.9157612635845, 5626.578006649497, 5684.573656975723, 5606.271184745978, 5622.971885140589, 5626.381098079208, 5633.0987042073275, 5688.516476099537, 4919.335889654886, 5074.543291103819, 5083.262926875583, 5114.565261952738, 5122.052420302219, 21782.0, 22088.447788805246, 22388.664170037464, 22518.66222006671, 22628.32115036535, 1669.5241856071084, 1706.6074802795426, 1710.6493168900345, 1715.5625315544457, 1720.9311627534883, 14704.411823527045, 14789.0, 15206.315715792816, 15269.38922443101, 15368.462103826312, 1873.8875667459995, 1929.170456703617, 1939.1273926732886, 1942.7183058456585, 2090.143041353038, 78847.21152788456, 85724.0, 88573.0, 94423.52788236084, 94811.0518894809, 10988.285761425483, 11381.544738210545, 11393.088552915748, 11439.428028598702, 11448.94275528617, 15870.285837137357, 15889.205539722967, 16004.279807408695, 16009.359625615078, 16015.599610009609, 7263.2736726328, 7577.431692623075, 7602.353799927068, 7633.2366763323225, 7809.0, 6692.732290708414, 6737.753515599532, 6785.93214067853, 6840.042394064735, 6886.10480637514, 7082.822929426702, 7086.964565177141, 7089.645517724093, 7098.60957647324, 7203.639818009078, 2086.76002259739, 2106.8841213733085, 2114.1754715660904, 2120.8409369297055, 2257.2912504994074, 844.2528362399198, 873.4671850171391, 876.1763941894726, 881.5636260051316, 910.7677542226689, 17064.829351706325, 17074.060926649152, 17257.56856078608, 17441.825581744273, 18005.279788808562, 878.7451639024739, 885.7077164535688, 891.4116682989196, 894.0924961164424, 903.7830920579014, 9324.254059675346, 9728.659496917715, 9752.21982241419, 9770.0, 9926.652567160114, 340613.0, 343769.0, 345752.0, 348403.0, 351035.0, 68105.65947170233, 69733.30266697268, 70348.0, 70624.0, 72043.6397818018, 1034.3380236648702, 1055.5883205549842, 1069.2087854987253, 1071.57672719277, 1076.8923107689325, 14534.273286335429, 14722.190279534729, 14746.262686865828, 14849.183294918883, 15280.15959122259, 36102.45846312255, 36261.81869090637, 36351.0, 37109.443358349105, 37230.25539489249, 43699.12601747883, 44861.102777943604, 45572.0, 45636.08727825491, 46386.76806615946, 8020.558869262247, 8148.429609927248, 8303.294219991127, 8333.791655208426, 8421.473557932473, 12329.938350308192, 12528.498860045496, 12650.873491265338, 12656.557020504239, 13073.673158171121, 10759.892401076202, 10944.671659850217, 10988.725281867697, 11008.889911100787, 11366.147538934778, 10456.372617642966, 10486.0, 10489.370637761758, 10608.310459820086, 10768.0, 10728.624498142528, 10848.294860834021, 10909.0, 11096.500657470271, 11098.50056747432, 7821.0, 8003.719869804529, 8127.268545830903, 8158.510489370657, 8257.133001034805, 10634.840477393, 10794.136469082612, 10839.349639021684, 10846.67459976202, 11166.385848778395], "value": 8782.413137919595, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1238.5726924211147, 1293.2240655606638, 1300.2458574027066, 1312.3635037007052, 1313.7044165062855, 10108.393496390212, 10527.684169474918, 10532.157427405808, 10587.15302775778, 10813.783724325529, 10524.894751052487, 10703.625373111943, 10728.78542429153, 10729.927007299266, 10732.19508536859, 2137.3694760045823, 2147.5490147069136, 2164.0910817456706, 2177.0638625391075, 2183.5632873425297, 2184.1045171479695, 2226.065052677871, 2238.2837492002564, 2245.820334373246, 2248.1344682297354, 2212.0, 2225.9888700556558, 2246.5731511012855, 2248.022110381981, 2259.344790010903, 2147.9033443495, 2180.13884515617, 2183.4213933307688, 2192.48476607997, 2197.4176843136584, 2006.5084054406764, 2137.845563395764, 2187.1798075721604, 2197.571473562656, 2203.3610253026604, 10271.435071071088, 10291.691249262534, 10319.277650564463, 10361.222908281909, 10378.532966016472, 5570.944290557123, 5690.4025077367105, 5736.4550367715, 5740.282464691913, 5741.0, 3286.4577344738327, 3563.7149028077692, 3590.299891521154, 3612.6387361263664, 3620.31214069326, 1050.0811789684026, 1056.2025670618712, 1091.9727006824814, 1097.1442275025413, 1110.955561777536, 15262.694746105126, 15293.235338233155, 15400.22998850053, 15470.45853395137, 15502.457413990456, 4875.975620121877, 4960.454350021495, 5065.189569668835, 5091.338126043591, 5098.46466121052, 10846.0, 10857.0, 10864.348139111678, 10900.07349375312, 10931.890681093088, 5516.531094856902, 5558.44415558449, 5559.082751346064, 5559.527440167551, 5567.498925096761, 4848.272759086165, 4887.340209071801, 4951.950480495221, 4962.702237865739, 5149.330587023663, 3790.0903783092413, 3877.84488620452, 3900.239453306578, 3986.9601303986587, 4038.313486707208, 1172.1033409441784, 1187.1808452167977, 1196.132803717298, 1203.5967950736601, 1206.9336186509827, 676.2189670930084, 697.2609034423527, 698.2179958446573, 705.5484489926451, 719.8344380792447, 5087.03346364197, 5240.318758561362, 5254.211868219798, 5343.519083282523, 5423.484768946943, 537.223711736537, 546.3089192171906, 556.9805056823072, 559.7089513453063, 562.05013527139, 3293.5883014623173, 3479.7042251408916, 3537.911552211215, 3569.411047177187, 3658.579263384692, 12708.237505749685, 13610.251436171106, 13672.726545469035, 13686.794698079537, 13697.726045479034, 13026.869731302566, 13471.663208419672, 13681.726365472834, 13730.588082357544, 13739.106958047894, 7597.278258565428, 7823.56970366624, 7846.607669616496, 7850.332721718718, 7877.3304269136615, 5519.9448005521035, 5558.66648001105, 5589.972050139723, 5656.0667489865355, 5683.204351390726, 11518.0, 11669.0, 11742.70643233926, 11745.588904388305, 12006.579769708018, 12084.577039803917, 12193.207441516628, 12338.75322493563, 12345.69135771577, 12439.067069969607, 7284.745033923788, 7461.477696561188, 7494.5503269803985, 7495.512791668524, 7512.962435187789, 9251.76870578241, 9305.395149315273, 9348.485833279236, 9354.111359420844, 9496.287778416508, 7984.6806127754235, 8064.314533264738, 8087.191280872101, 8164.428490005643, 8174.141715119827, 7574.394048475999, 7639.312461878458, 7641.923580764121, 7745.883811742716, 8183.6726530938095, 6895.75864844728, 6964.477664175309, 6971.442284617117, 6981.371676549135, 7004.0, 4882.170031094794, 4920.892799120169, 4950.45544990058, 5010.473900240422, 5163.586913046872, 5128.256402821645, 5133.537981581676, 5192.324997750419, 5214.400343960493, 5316.813911513079], "value": 4660.409960798177, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.13488302489156, 378.1774640157656, 379.7398781834444, 387.7053439386066, 393.77358019138995, 5486.286782718251, 5533.142362933747, 5547.751755854931, 5585.385607583163, 5592.189132575779, 5371.167469042305, 5447.809326673567, 5449.237106805051, 5467.6719396836215, 5485.424030476803, 4376.1247750449875, 4379.693421460499, 4381.123775244963, 4387.0, 4398.186335527922, 4297.892552686192, 4376.912461750763, 4397.2304846651705, 4413.411171978101, 4418.491873434564, 4330.484330484337, 4337.804798784046, 4347.174036932973, 4347.304431290994, 4362.694611377205, 4371.125774845028, 4374.671899607511, 4376.19040477511, 4386.188555117314, 4392.297232442794, 3939.881803545898, 3983.621555952209, 3985.880423587297, 4011.1576568920564, 4015.257177422157, 5404.567634589223, 5422.267993820823, 5429.212764149176, 5442.428545002757, 5453.209284653703, 5194.792208311663, 5195.19474481456, 5210.036143313499, 5216.165413533817, 5227.686338819645, 5627.324721033502, 5838.883222335572, 5843.474087332118, 5884.0585506318785, 5895.4399332063385, 4449.955500444987, 4459.308807134899, 4477.417935668343, 4481.103779244132, 4483.551644835523, 5990.640561566276, 6163.630182189083, 6187.4740647045055, 6216.658083805389, 6308.526860485436, 4352.129574085196, 4357.368181613649, 4363.912721745547, 4371.30059190528, 4381.058072514361, 4405.185040767468, 4444.688871779009, 4445.066536027471, 4451.443569553806, 4457.420535330386, 4944.25836124577, 4963.939964914593, 4971.279164521196, 5016.2224855147515, 5045.445001049881, 5868.67722275279, 5885.087811389241, 5886.735096920649, 5899.469047785634, 5901.3508514063415, 1621.1975072339267, 1637.001429128231, 1641.8111917129684, 1644.21077882617, 1644.6052947292565, 1126.2622981946838, 1150.8216226484908, 1171.2211379432752, 1173.530587764901, 1187.922785018971, 5094.2358646203365, 5100.948990510047, 5122.667026643257, 5146.871328216825, 5163.122269214243, 5973.223480947449, 6078.908816367758, 6095.603785753912, 6115.785947491817, 6129.417705317987, 5120.359955005624, 5151.2530683050745, 5157.716325602128, 5163.122269214167, 5166.328377310925, 3173.0798068559857, 3216.388886111631, 3228.386606544749, 3264.55928449661, 3265.297960938362, 5500.28496295479, 5605.831825045255, 5619.213310136584, 5619.831405057855, 5649.802256921071, 6114.266288045463, 6171.197744293213, 6177.135201071854, 6185.659788711574, 6231.3145553989025, 5418.972905135607, 5597.916031259534, 5606.775728970877, 5608.439156084359, 5630.380658127603, 6025.457708806229, 6071.848203794941, 6076.908846367396, 6077.4226448487325, 6079.483243924316, 5788.160716696139, 5959.824663997696, 6001.729922153426, 6017.969910150421, 6022.819315420545, 5584.162375643686, 5655.7454914528125, 5655.830325090254, 5660.349059858005, 5675.716214189357, 4150.875473735793, 4178.8328466860985, 4180.784184382283, 4183.790810459525, 4198.685098617555, 5958.791442299499, 6064.818055458343, 6105.236845394325, 6122.448979591858, 6124.510039196764, 5841.474267315962, 5849.883002339844, 5869.794557190648, 5874.206982057539, 5886.440788125121, 5738.598298119258, 5861.794837180678, 5873.794417195378, 5879.323877753942, 5886.411358864079, 5695.544356451391, 5700.743466544099, 5708.942910571007, 5728.283964504437, 5757.769689212552, 5862.443067908542, 5889.175515427758, 5895.587308888336, 5898.705064746831, 5905.0, 5613.803516877053, 5689.487946084872, 5727.68497732612, 5745.425457454221, 5747.827565173052], "value": 4481.461594274975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.126825979474, 751.1174370115115, 756.8826831841067, 770.7610640701383, 781.8709912864376, 10939.890601093986, 11401.315921044743, 13395.79906301405, 13981.860181398182, 14141.787873181898, 14756.0, 15182.696346073071, 15255.38978440861, 15276.618084547892, 15315.463958761446, 827.896512935883, 857.1942374168293, 861.5821326656567, 861.9310455163603, 865.3855762408697, 904.055262250946, 904.5477261369315, 906.1210625693067, 906.2885634776702, 907.3557773980482, 939.3940908114262, 942.8774259346276, 944.3719926249071, 946.0208684012049, 946.5220063867737, 943.8914524829629, 945.5650400815599, 951.0109486134412, 951.5527701980059, 951.7525443384701, 693.9895901561481, 695.408902432928, 697.7976386847808, 697.8883378659441, 700.1213477086275, 14035.368408421544, 14367.0, 14450.566483005421, 14484.855151448455, 14574.854251457456, 14948.252587370587, 15319.846801531954, 15366.462173823862, 15668.059916405053, 15957.601059973478, 11761.294322340687, 11869.406529673483, 11899.107566932515, 11964.70088247792, 11983.400829958468, 2908.3310838507264, 2918.6643535993207, 2925.692802255775, 2927.1072322941495, 2935.4129174165037, 69243.3075669242, 69903.3009669902, 70406.0, 70667.2933270671, 71678.64160679163, 10755.946220269005, 10891.618793342195, 10950.945245273722, 11014.229003969645, 11066.446677666085, 19550.902245488967, 19838.504037398892, 21572.0, 22100.33698989033, 22393.0, 5814.273215848019, 6011.969940150271, 6092.634441933409, 6142.078688196717, 6148.631082134997, 2789.8884044638394, 2872.8707208175683, 2876.956845647317, 2882.4811533924094, 2886.581445690363, 3554.8933531993566, 3593.443016332473, 3605.6574625410544, 3629.8366573503727, 3736.5889752127246, 735.6505659811546, 748.3788455581854, 751.549070557661, 755.1844008470838, 757.238974830292, 554.9130652742602, 575.65748379714, 580.1703563903658, 593.9287285525678, 616.0789619518848, 9843.704688859345, 10056.245781566411, 10270.486475676187, 10877.456127193609, 10974.176936729777, 581.7324030945813, 590.3270271890049, 590.583638534832, 595.8986972214734, 610.7862248213179, 4293.119910418357, 4549.608614455404, 4555.043440877453, 4677.462091859412, 4704.858854234379, 60882.39117608856, 61640.0, 61768.44084032458, 61812.0, 64146.679266604304, 55960.44039559552, 58288.70855645695, 58595.707021465474, 58788.412115879146, 58941.0, 49996.250431200875, 50821.74589127031, 51293.7435312821, 51325.48674513207, 53442.465575344526, 9586.760330991781, 9696.0, 9770.169535589555, 9771.853422198816, 10003.899961000297, 25907.481850363263, 26633.866830665724, 26721.33196670099, 26843.0, 26846.59730104011, 31396.0, 31978.840105800253, 32069.358612827145, 32754.0, 33039.0, 11911.0, 11993.40032998364, 12032.217905836093, 12148.635540933787, 12236.204646698292, 14496.637584060483, 15262.618434539225, 15576.84423155754, 15932.362705492114, 16055.678886421972, 13365.331733413484, 13635.522756703467, 14421.855781442471, 14896.925515372353, 15167.620809479851, 13018.674533136747, 13139.343032848128, 14816.254910171008, 15276.77084843706, 15277.0, 13743.244121573409, 13904.165750055028, 13940.233287169303, 14225.0, 14467.710645787236, 9690.563924623268, 9869.309148359545, 9972.451515166735, 10158.746031349276, 10339.327943683636, 10882.769032348508, 11572.826407603725, 11603.303801771921, 11753.294802311888, 11764.647060588197], "value": 6736.789566404224, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 111.0, 111.0, 110.0, 113.0, 113.0, 113.0, 113.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 129.0, 124.0, 180.0, 131.0, 122.0, 126.0, 125.0, 148.0, 129.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 167.0, 165.0, 170.0, 173.0, 170.0, 163.0, 164.0, 163.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 121.0, 76.0, 74.0, 75.0, 75.0, 95.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 112.0, 83.0, 84.0, 84.0, 96.0, 83.0, 83.0, 102.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 117.0, 114.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 155.0, 153.0, 153.0, 152.0, 153.0, 152.0, 152.0, 152.0, 150.0], "value": 152.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 56.0, 58.0, 61.0, 57.0, 58.0, 56.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 56.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 84.0, 92.0, 82.0, 82.0, 83.0, 84.0, 85.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 128.0, 141.0, 141.0, 142.0, 130.0, 130.0, 133.0, 178.0, 135.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 199.0, 197.0, 193.0, 195.0, 184.0, 195.0, 192.0, 191.0, 191.0], "value": 192.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 73.0, 76.0, 78.0, 76.0, 73.0, 72.0, 75.0, 76.0, 73.0], "value": 76.1, "unit": "score"}]}]} 16:32:21 INFO - Return code: 0 16:32:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:32:21 INFO - # TBPL SUCCESS # 16:32:21 INFO - Running post-action listener: _resource_record_post_action 16:32:21 INFO - [mozharness: 2017-05-13 23:32:21.388840Z] Finished run-tests step (success) 16:32:21 INFO - Running post-run listener: _resource_record_post_run 16:32:21 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 368607232; Read time: 112; Write time: 322588 16:32:21 INFO - TinderboxPrint: CPU usage
13.3% 16:32:21 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 112 16:32:21 INFO - TinderboxPrint: I/O write bytes / time
368,607,232 / 322,588 16:32:21 INFO - TinderboxPrint: CPU idle
8,305.8 (86.7%) 16:32:21 INFO - TinderboxPrint: CPU user
1,214.5 (12.7%) 16:32:21 INFO - TinderboxPrint: Swap in / out
0 / 0 16:32:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 41103360; Read time: 0; Write time: 15012 16:32:21 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8192; Write bytes: 261775360; Read time: 112; Write time: 177904 16:32:22 INFO - Running post-run listener: _upload_blobber_files 16:32:22 INFO - Blob upload gear active. 16:32:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:32:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:32:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:32:22 INFO - (blobuploader) - INFO - Open directory for files ... 16:32:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:32:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:32:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:23 INFO - (blobuploader) - INFO - Done attempting. 16:32:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:32:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:32:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:24 INFO - (blobuploader) - INFO - Done attempting. 16:32:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:32:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:32:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:25 INFO - (blobuploader) - INFO - Done attempting. 16:32:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:32:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:32:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:28 INFO - (blobuploader) - INFO - Done attempting. 16:32:28 INFO - (blobuploader) - INFO - Iteration through files over. 16:32:28 INFO - Return code: 0 16:32:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:32:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:32:28 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b44c03ce119d4cb06c42e27f95e30edd6ae8fe7625c664475abc437ce8df8f03f63f3d0f0fcbd18487c02ddf0751700a0a14f9719c2ad0e2425281cbde85168", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7cadc4affd8397d7c696f3a181e41743a2b697458d4b5cdce3f25ab96cf00ed37f4fe19035a4d056614d6b6b38300e5e3bc712c491f11cce2f2018d7df80ccc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ceec95a5c5c616c5f0b8f3bb6443ff5a227af7d4d19c24dce156a2e998f584f24da58fd34017ae8838d01f32f96f634389923bc80557264ab6d04456def35fb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0989c78ceb658a70b46ff245d90028e0883eaf3b12897baa7087bc07dcebeadcbde6a4f8a8e12375063ead0bd31ce659a41dbfa8bb2a507dddb93aeeaa160af"} 16:32:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:32:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:32:28 INFO - Contents: 16:32:28 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b44c03ce119d4cb06c42e27f95e30edd6ae8fe7625c664475abc437ce8df8f03f63f3d0f0fcbd18487c02ddf0751700a0a14f9719c2ad0e2425281cbde85168", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7cadc4affd8397d7c696f3a181e41743a2b697458d4b5cdce3f25ab96cf00ed37f4fe19035a4d056614d6b6b38300e5e3bc712c491f11cce2f2018d7df80ccc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ceec95a5c5c616c5f0b8f3bb6443ff5a227af7d4d19c24dce156a2e998f584f24da58fd34017ae8838d01f32f96f634389923bc80557264ab6d04456def35fb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0989c78ceb658a70b46ff245d90028e0883eaf3b12897baa7087bc07dcebeadcbde6a4f8a8e12375063ead0bd31ce659a41dbfa8bb2a507dddb93aeeaa160af"} 16:32:28 INFO - Running post-run listener: copy_logs_to_upload_dir 16:32:28 INFO - Copying logs to upload dir... 16:32:28 INFO - mkdir: /builds/slave/test/build/upload/logs 16:32:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.198838 ========= master_lag: 0.60 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-13 16:32:28.199682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-13 16:32:28.208518) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b44c03ce119d4cb06c42e27f95e30edd6ae8fe7625c664475abc437ce8df8f03f63f3d0f0fcbd18487c02ddf0751700a0a14f9719c2ad0e2425281cbde85168", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7cadc4affd8397d7c696f3a181e41743a2b697458d4b5cdce3f25ab96cf00ed37f4fe19035a4d056614d6b6b38300e5e3bc712c491f11cce2f2018d7df80ccc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ceec95a5c5c616c5f0b8f3bb6443ff5a227af7d4d19c24dce156a2e998f584f24da58fd34017ae8838d01f32f96f634389923bc80557264ab6d04456def35fb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0989c78ceb658a70b46ff245d90028e0883eaf3b12897baa7087bc07dcebeadcbde6a4f8a8e12375063ead0bd31ce659a41dbfa8bb2a507dddb93aeeaa160af"} build_url:https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.010169 build_url: 'https://queue.taskcluster.net/v1/task/Zpk4sgI2Q8SzGk9aKnzCGg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b44c03ce119d4cb06c42e27f95e30edd6ae8fe7625c664475abc437ce8df8f03f63f3d0f0fcbd18487c02ddf0751700a0a14f9719c2ad0e2425281cbde85168", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7cadc4affd8397d7c696f3a181e41743a2b697458d4b5cdce3f25ab96cf00ed37f4fe19035a4d056614d6b6b38300e5e3bc712c491f11cce2f2018d7df80ccc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ceec95a5c5c616c5f0b8f3bb6443ff5a227af7d4d19c24dce156a2e998f584f24da58fd34017ae8838d01f32f96f634389923bc80557264ab6d04456def35fb9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f0989c78ceb658a70b46ff245d90028e0883eaf3b12897baa7087bc07dcebeadcbde6a4f8a8e12375063ead0bd31ce659a41dbfa8bb2a507dddb93aeeaa160af"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-13 16:32:28.238211) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:32:28.238567) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1494713078.373549-308940789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-13 16:32:28.290906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-13 16:32:28.292309) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-13 16:32:28.292680) ========= ========= Total master_lag: 0.74 =========