builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1494551799.0 results: success (0) revision: 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:38.999986) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:39.000495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:39.000804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:39.012562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:39.012900) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-11 18:16:39-- 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% 226M=0s 2017-05-11 18:16:39 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.164868 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:39.189520) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:39.189829) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014703 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:39.239328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:39.239671) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc --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 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc --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=8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-11 18:16:39,387 truncating revision to first 12 chars 2017-05-11 18:16:39,387 Setting DEBUG logging. 2017-05-11 18:16:39,387 attempt 1/10 2017-05-11 18:16:39,387 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2a8e0c4be57d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-11 18:16:39,688 unpacking tar archive at: mozilla-central-2a8e0c4be57d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563691 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:39.816527) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:39.816849) ========= script_repo_revision: 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:39.817272) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:39.817571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 18:16:39.826686) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-11 18:16:39.827175) ========= /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=8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:16:40 INFO - MultiFileLogger online at 20170511 18:16:40 in /builds/slave/test 18:16:40 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 18:16:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:16:40 INFO - {'append_to_log': False, 18:16:40 INFO - 'base_work_dir': '/builds/slave/test', 18:16:40 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:16:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:16:40 INFO - 'branch': 'Firefox-Non-PGO', 18:16:40 INFO - 'buildbot_json_path': 'buildprops.json', 18:16:40 INFO - 'config_files': ('talos/linux_config.py',), 18:16:40 INFO - 'default_actions': ('clobber', 18:16:40 INFO - 'read-buildbot-config', 18:16:40 INFO - 'download-and-extract', 18:16:40 INFO - 'populate-webroot', 18:16:40 INFO - 'create-virtualenv', 18:16:40 INFO - 'install', 18:16:40 INFO - 'run-tests'), 18:16:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:16:40 INFO - 'download_minidump_stackwalk': True, 18:16:40 INFO - 'download_symbols': 'ondemand', 18:16:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:16:40 INFO - 'tooltool.py': '/tools/tooltool.py', 18:16:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:16:40 INFO - '/tools/misc-python/virtualenv.py')}, 18:16:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:16:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:16:40 INFO - 'gecko_profile': False, 18:16:40 INFO - 'gecko_profile_interval': 0, 18:16:40 INFO - 'installer_path': 'installer.exe', 18:16:40 INFO - 'log_level': 'info', 18:16:40 INFO - 'log_name': 'talos', 18:16:40 INFO - 'log_to_console': True, 18:16:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:16:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:16:40 INFO - 'opt_config_files': (), 18:16:40 INFO - 'pip_index': False, 18:16:40 INFO - 'suite': 'dromaeojs-e10s', 18:16:40 INFO - 'system_bits': '32', 18:16:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:16:40 INFO - 'title': 'talos-linux64-ix-089', 18:16:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:16:40 INFO - 'use_talos_json': True, 18:16:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:16:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:16:40 INFO - 'work_dir': 'build'} 18:16:40 INFO - [mozharness: 2017-05-12 01:16:40.076518Z] Running clobber step. 18:16:40 INFO - Running pre-action listener: _resource_record_pre_action 18:16:40 INFO - Running main action method: clobber 18:16:40 INFO - rmtree: /builds/slave/test/build 18:16:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:16:41 INFO - Running post-action listener: _resource_record_post_action 18:16:41 INFO - [mozharness: 2017-05-12 01:16:41.008184Z] Finished clobber step (success) 18:16:41 INFO - [mozharness: 2017-05-12 01:16:41.008283Z] Running read-buildbot-config step. 18:16:41 INFO - Running pre-action listener: _resource_record_pre_action 18:16:41 INFO - Running main action method: read_buildbot_config 18:16:41 INFO - Using buildbot properties: 18:16:41 INFO - { 18:16:41 INFO - "project": "", 18:16:41 INFO - "product": "firefox", 18:16:41 INFO - "who": "kwierso@gmail.com", 18:16:41 INFO - "installer_path": "public/build/target.tar.bz2", 18:16:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:16:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:16:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:16:41 INFO - "stage_platform": "linux64", 18:16:41 INFO - "basedir": "/builds/slave/test", 18:16:41 INFO - "buildnumber": 871, 18:16:41 INFO - "platform": "ubuntu64_hw", 18:16:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:16:41 INFO - "slavebuilddir": "test", 18:16:41 INFO - "taskId": "KK-ymxyaRIeZh39KHPj3xA", 18:16:41 INFO - "branch": "mozilla-central", 18:16:41 INFO - "script_repo_revision": "production", 18:16:41 INFO - "revision": "2a8e0c4be57d244bf59543750d047b2ab7c8bbdc", 18:16:41 INFO - "slavename": "talos-linux64-ix-089", 18:16:41 INFO - "repo_path": "mozilla-central" 18:16:41 INFO - } 18:16:41 INFO - Finding installer, test and symbols from parent task. 18:16:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KK-ymxyaRIeZh39KHPj3xA'}, attempt #1 18:16:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KK-ymxyaRIeZh39KHPj3xA'}, attempt #1 18:16:42 INFO - Task dependencies: dGUIyOthRJK_MESGw0MYbQ 18:16:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ'}, attempt #1 18:16:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.tar.bz2 18:16:42 INFO - Set test_url: https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/test_packages.json 18:16:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.crashreporter-symbols.zip 18:16:42 INFO - Running post-action listener: _resource_record_post_action 18:16:42 INFO - [mozharness: 2017-05-12 01:16:42.482323Z] Finished read-buildbot-config step (success) 18:16:42 INFO - [mozharness: 2017-05-12 01:16:42.482541Z] Running download-and-extract step. 18:16:42 INFO - Running pre-action listener: _resource_record_pre_action 18:16:42 INFO - Running main action method: download_and_extract 18:16:42 INFO - mkdir: /builds/slave/test/build/tests 18:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:16:42 INFO - trying https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.test_packages.json 18:16:42 INFO - Downloading https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:16:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:16:43 INFO - Downloaded 986 bytes. 18:16:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:16:43 INFO - Using the following test package requirements: 18:16:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:16:43 INFO - u'common': [u'target.common.tests.zip'], 18:16:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:16:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:16:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:16:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:16:43 INFO - u'mozbase': [u'target.common.tests.zip'], 18:16:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:16:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:16:43 INFO - u'web-platform': [u'target.common.tests.zip', 18:16:43 INFO - u'target.web-platform.tests.zip'], 18:16:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:16:43 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:16:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.common.tests.zip 18:16:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:16:43 INFO - Fetch https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.common.tests.zip into memory 18:16:44 INFO - Content-Length response header: 58591020 18:16:44 INFO - Bytes received: 58591020 18:16:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:16:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.common.tests.zip 18:16:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:16:53 INFO - Fetch https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.common.tests.zip into memory 18:16:55 INFO - Content-Length response header: 58591020 18:16:55 INFO - Bytes received: 58591020 18:17:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.talos.tests.zip 18:17:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:17:06 INFO - Fetch https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.talos.tests.zip into memory 18:17:06 INFO - Content-Length response header: 14409411 18:17:06 INFO - Bytes received: 14409411 18:17:07 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')]} 18:17:07 INFO - trying https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.tar.bz2 18:17:07 INFO - Downloading https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:17:08 INFO - Downloaded 63323464 bytes. 18:17:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.tar.bz2 18:17:08 INFO - mkdir: /builds/slave/test/properties 18:17:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:17:08 INFO - Writing to file /builds/slave/test/properties/build_url 18:17:08 INFO - Contents: 18:17:08 INFO - build_url:https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.tar.bz2 18:17:08 INFO - Running post-action listener: _resource_record_post_action 18:17:08 INFO - Running post-action listener: set_extra_try_arguments 18:17:08 INFO - [mozharness: 2017-05-12 01:17:08.265814Z] Finished download-and-extract step (success) 18:17:08 INFO - [mozharness: 2017-05-12 01:17:08.265911Z] Running populate-webroot step. 18:17:08 INFO - Running pre-action listener: _resource_record_pre_action 18:17:08 INFO - Running main action method: populate_webroot 18:17:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:17:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:17:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:17:08 INFO - '--tppagecycles', 18:17:08 INFO - '7'], 18:17:08 INFO - 'tests': ['tsvgm']}}, 18:17:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:17:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:17:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:17:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:17:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:17:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:17:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:17:08 INFO - 'talos_options': ['--disable-e10s'], 18:17:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:17:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:17:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:17:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:17:08 INFO - 'talos_options': ['--disable-e10s'], 18:17:08 INFO - 'tests': ['damp', 'tps']}, 18:17:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:17:08 INFO - 'tests': ['damp', 'tps']}, 18:17:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:17:08 INFO - 'tests': ['dromaeo_dom']}, 18:17:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:17:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:17:08 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:17:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:17:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:17:08 INFO - 'tests': ['a11yr', 18:17:08 INFO - 'ts_paint', 18:17:08 INFO - 'tpaint', 18:17:08 INFO - 'sessionrestore', 18:17:08 INFO - 'sessionrestore_no_auto_restore', 18:17:08 INFO - 'tabpaint']}, 18:17:08 INFO - 'other-e10s': {'tests': ['a11yr', 18:17:08 INFO - 'ts_paint', 18:17:08 INFO - 'tpaint', 18:17:08 INFO - 'sessionrestore', 18:17:08 INFO - 'sessionrestore_no_auto_restore', 18:17:08 INFO - 'tabpaint']}, 18:17:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:17:08 INFO - 'ts_paint', 18:17:08 INFO - 'tpaint', 18:17:08 INFO - 'sessionrestore', 18:17:08 INFO - 'sessionrestore_no_auto_restore', 18:17:08 INFO - 'tabpaint']}, 18:17:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:17:08 INFO - 'ts_paint', 18:17:08 INFO - 'tpaint', 18:17:08 INFO - 'sessionrestore', 18:17:08 INFO - 'sessionrestore_no_auto_restore', 18:17:08 INFO - 'tabpaint']}, 18:17:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:17:08 INFO - 'tests': ['a11yr', 18:17:08 INFO - 'ts_paint', 18:17:08 INFO - 'tpaint', 18:17:08 INFO - 'sessionrestore', 18:17:08 INFO - 'sessionrestore_no_auto_restore', 18:17:08 INFO - 'tabpaint']}, 18:17:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:17:08 INFO - 'tests': ['a11yr', 18:17:08 INFO - 'ts_paint', 18:17:08 INFO - 'tpaint', 18:17:08 INFO - 'sessionrestore', 18:17:08 INFO - 'sessionrestore_no_auto_restore', 18:17:08 INFO - 'tabpaint']}, 18:17:08 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:17:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:17:08 INFO - 'bloom_basic_ref']}, 18:17:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:17:08 INFO - 'tests': ['tsvgx', 18:17:08 INFO - 'tsvgr_opacity', 18:17:08 INFO - 'tart', 18:17:08 INFO - 'tscrollx', 18:17:08 INFO - 'cart', 18:17:08 INFO - 'tsvg_static']}, 18:17:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:17:08 INFO - 'tsvgr_opacity', 18:17:08 INFO - 'tart', 18:17:08 INFO - 'tscrollx', 18:17:08 INFO - 'cart', 18:17:08 INFO - 'tsvg_static']}, 18:17:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:17:08 INFO - 'talos_options': ['--disable-e10s'], 18:17:08 INFO - 'tests': ['tp5o']}, 18:17:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:17:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:17:08 INFO - 'talos_options': ['--disable-e10s', 18:17:08 INFO - '--xperf_path', 18:17:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:17:08 INFO - 'tests': ['tp5n']}, 18:17:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:17:08 INFO - 'talos_options': ['--xperf_path', 18:17:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:17:08 INFO - 'tests': ['tp5n']}}, 18:17:08 INFO - 'talos.zip': {'path': '', 18:17:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:17:08 INFO - Running post-action listener: _resource_record_post_action 18:17:08 INFO - [mozharness: 2017-05-12 01:17:08.279492Z] Finished populate-webroot step (success) 18:17:08 INFO - [mozharness: 2017-05-12 01:17:08.279581Z] Running create-virtualenv step. 18:17:08 INFO - Running pre-action listener: _resource_record_pre_action 18:17:08 INFO - Running main action method: create_virtualenv 18:17:08 INFO - Creating virtualenv /builds/slave/test/build/venv 18:17:08 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 18:17:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:17:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:17:08 INFO - Using real prefix '/usr' 18:17:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:17:08 INFO - Installing distribute.............................................................................................................................................................................................done. 18:17:10 INFO - Installing pip.................done. 18:17:10 INFO - Return code: 0 18:17:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:17:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:17:11 INFO - Reading from file tmpfile_stdout 18:17:11 INFO - Output received: 18:17:11 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) 18:17:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:17: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')]} 18:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17: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')]} 18:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1396a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1539a30>, '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 0x153a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153aca0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', '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 18:17: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', 'pip>=1.5'] in /builds/slave/test/build 18:17: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 pip>=1.5 18:17:11 INFO - Using env: {'DISPLAY': ':0', 18:17:11 INFO - 'HOME': '/home/cltbld', 18:17:11 INFO - 'LANG': 'en_US.UTF-8', 18:17:11 INFO - 'LANGUAGE': 'en_US:en', 18:17:11 INFO - 'LOGNAME': 'cltbld', 18:17:11 INFO - 'MAIL': '/var/mail/cltbld', 18:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:11 INFO - 'MOZ_NO_REMOTE': '1', 18:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:11 INFO - 'NO_EM_RESTART': '1', 18:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:11 INFO - 'PWD': '/builds/slave/test', 18:17:11 INFO - 'SHELL': '/bin/bash', 18:17:11 INFO - 'SHLVL': '1', 18:17:11 INFO - 'TERM': 'linux', 18:17:11 INFO - 'TMOUT': '86400', 18:17:11 INFO - 'USER': 'cltbld', 18:17:11 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', 18:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:11 INFO - '_': '/tools/buildbot/bin/python'} 18:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:11 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 18:17:11 INFO - Cleaning up... 18:17:11 INFO - Return code: 0 18:17:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:17: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')]} 18:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17: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')]} 18:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17: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', '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 0x11ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1396a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1539a30>, '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 0x153a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153aca0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', '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 18:17: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:17: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 psutil>=3.1.1 18:17:11 INFO - Using env: {'DISPLAY': ':0', 18:17:11 INFO - 'HOME': '/home/cltbld', 18:17:11 INFO - 'LANG': 'en_US.UTF-8', 18:17:11 INFO - 'LANGUAGE': 'en_US:en', 18:17:11 INFO - 'LOGNAME': 'cltbld', 18:17:11 INFO - 'MAIL': '/var/mail/cltbld', 18:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:11 INFO - 'MOZ_NO_REMOTE': '1', 18:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:11 INFO - 'NO_EM_RESTART': '1', 18:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:11 INFO - 'PWD': '/builds/slave/test', 18:17:11 INFO - 'SHELL': '/bin/bash', 18:17:11 INFO - 'SHLVL': '1', 18:17:11 INFO - 'TERM': 'linux', 18:17:11 INFO - 'TMOUT': '86400', 18:17:11 INFO - 'USER': 'cltbld', 18:17:11 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', 18:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:11 INFO - '_': '/tools/buildbot/bin/python'} 18:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:11 INFO - Downloading/unpacking psutil>=3.1.1 18:17: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 18:17: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 18:17: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 18:17: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 18:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:17:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:17:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:17:12 INFO - Installing collected packages: psutil 18:17:12 INFO - Running setup.py install for psutil 18:17:12 INFO - building 'psutil._psutil_linux' extension 18:17:12 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 18:17:12 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 18:17:12 INFO - building 'psutil._psutil_posix' extension 18:17:12 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 18:17:13 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 18:17:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:17:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:17:13 INFO - Successfully installed psutil 18:17:13 INFO - Cleaning up... 18:17:13 INFO - Return code: 0 18:17:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:17:13 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')]} 18:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:13 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')]} 18:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:13 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 0x11ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1396a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1539a30>, '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 0x153a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153aca0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', '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 18:17:13 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 18:17:13 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 18:17:13 INFO - Using env: {'DISPLAY': ':0', 18:17:13 INFO - 'HOME': '/home/cltbld', 18:17:13 INFO - 'LANG': 'en_US.UTF-8', 18:17:13 INFO - 'LANGUAGE': 'en_US:en', 18:17:13 INFO - 'LOGNAME': 'cltbld', 18:17:13 INFO - 'MAIL': '/var/mail/cltbld', 18:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:13 INFO - 'MOZ_NO_REMOTE': '1', 18:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:13 INFO - 'NO_EM_RESTART': '1', 18:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:13 INFO - 'PWD': '/builds/slave/test', 18:17:13 INFO - 'SHELL': '/bin/bash', 18:17:13 INFO - 'SHLVL': '1', 18:17:13 INFO - 'TERM': 'linux', 18:17:13 INFO - 'TMOUT': '86400', 18:17:13 INFO - 'USER': 'cltbld', 18:17:13 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', 18:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:13 INFO - '_': '/tools/buildbot/bin/python'} 18:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:17: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 18:17: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 18:17: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 18:17: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 18:17:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:17:14 INFO - Installing collected packages: mozsystemmonitor 18:17:14 INFO - Running setup.py install for mozsystemmonitor 18:17:14 INFO - Successfully installed mozsystemmonitor 18:17:14 INFO - Cleaning up... 18:17:14 INFO - Return code: 0 18:17:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:17: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')]} 18:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17: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')]} 18:17:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:14 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 0x11ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1396a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1539a30>, '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 0x153a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153aca0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', '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 18:17:14 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 18:17:14 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 18:17:14 INFO - Using env: {'DISPLAY': ':0', 18:17:14 INFO - 'HOME': '/home/cltbld', 18:17:14 INFO - 'LANG': 'en_US.UTF-8', 18:17:14 INFO - 'LANGUAGE': 'en_US:en', 18:17:14 INFO - 'LOGNAME': 'cltbld', 18:17:14 INFO - 'MAIL': '/var/mail/cltbld', 18:17:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:14 INFO - 'MOZ_NO_REMOTE': '1', 18:17:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:14 INFO - 'NO_EM_RESTART': '1', 18:17:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:14 INFO - 'PWD': '/builds/slave/test', 18:17:14 INFO - 'SHELL': '/bin/bash', 18:17:14 INFO - 'SHLVL': '1', 18:17:14 INFO - 'TERM': 'linux', 18:17:14 INFO - 'TMOUT': '86400', 18:17:14 INFO - 'USER': 'cltbld', 18:17:14 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', 18:17:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:14 INFO - '_': '/tools/buildbot/bin/python'} 18:17:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:14 INFO - Downloading/unpacking jsonschema==2.5.1 18:17:14 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 18:17:14 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 18:17:14 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 18:17:14 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 18:17:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:17:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:17:15 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 18:17:15 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 18:17:15 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 18:17:15 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 18:17:16 INFO - Downloading functools32-3.2.3-2.tar.gz 18:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:17:16 INFO - warning: no files found matching '*.txt' 18:17:16 INFO - no previously-included directories found matching 'build' 18:17:16 INFO - no previously-included directories found matching 'dist' 18:17:16 INFO - no previously-included directories found matching '.git*' 18:17:16 INFO - Installing collected packages: jsonschema, functools32 18:17:16 INFO - Running setup.py install for functools32 18:17:16 INFO - warning: no files found matching '*.txt' 18:17:16 INFO - no previously-included directories found matching 'build' 18:17:16 INFO - no previously-included directories found matching 'dist' 18:17:16 INFO - no previously-included directories found matching '.git*' 18:17:16 INFO - Successfully installed jsonschema functools32 18:17:16 INFO - Cleaning up... 18:17:16 INFO - Return code: 0 18:17:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1396a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1539a30>, '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 0x153a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153aca0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', '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 18:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:17:16 INFO - Using env: {'DISPLAY': ':0', 18:17:16 INFO - 'HOME': '/home/cltbld', 18:17:16 INFO - 'LANG': 'en_US.UTF-8', 18:17:16 INFO - 'LANGUAGE': 'en_US:en', 18:17:16 INFO - 'LOGNAME': 'cltbld', 18:17:16 INFO - 'MAIL': '/var/mail/cltbld', 18:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:16 INFO - 'MOZ_NO_REMOTE': '1', 18:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:16 INFO - 'NO_EM_RESTART': '1', 18:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:16 INFO - 'PWD': '/builds/slave/test', 18:17:16 INFO - 'SHELL': '/bin/bash', 18:17:16 INFO - 'SHLVL': '1', 18:17:16 INFO - 'TERM': 'linux', 18:17:16 INFO - 'TMOUT': '86400', 18:17:16 INFO - 'USER': 'cltbld', 18:17:16 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', 18:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:16 INFO - '_': '/tools/buildbot/bin/python'} 18:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:17:16 INFO - Cleaning up... 18:17:16 INFO - Return code: 0 18:17:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1396a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1539a30>, '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 0x153a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153aca0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', '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 18:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:17:16 INFO - Using env: {'DISPLAY': ':0', 18:17:16 INFO - 'HOME': '/home/cltbld', 18:17:16 INFO - 'LANG': 'en_US.UTF-8', 18:17:16 INFO - 'LANGUAGE': 'en_US:en', 18:17:16 INFO - 'LOGNAME': 'cltbld', 18:17:16 INFO - 'MAIL': '/var/mail/cltbld', 18:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:16 INFO - 'MOZ_NO_REMOTE': '1', 18:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:16 INFO - 'NO_EM_RESTART': '1', 18:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:16 INFO - 'PWD': '/builds/slave/test', 18:17:16 INFO - 'SHELL': '/bin/bash', 18:17:16 INFO - 'SHLVL': '1', 18:17:16 INFO - 'TERM': 'linux', 18:17:16 INFO - 'TMOUT': '86400', 18:17:16 INFO - 'USER': 'cltbld', 18:17:16 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', 18:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:16 INFO - '_': '/tools/buildbot/bin/python'} 18:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:16 INFO - Downloading/unpacking blobuploader==1.2.4 18:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:17 INFO - Downloading blobuploader-1.2.4.tar.gz 18:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:17:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:17:17 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 18:17:17 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 18:17:17 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 18:17:17 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 18:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:17:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:17: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 18:17: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 18:17: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 18:17: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 18:17:18 INFO - Downloading docopt-0.6.1.tar.gz 18:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:17:18 INFO - Installing collected packages: blobuploader, requests, docopt 18:17:18 INFO - Running setup.py install for blobuploader 18:17:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:17:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:17:18 INFO - Running setup.py install for requests 18:17:18 INFO - Running setup.py install for docopt 18:17:18 INFO - Successfully installed blobuploader requests docopt 18:17:18 INFO - Cleaning up... 18:17:18 INFO - Return code: 0 18:17:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:19 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 0x11ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1396a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1539a30>, '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 0x153a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153aca0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', '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 18:17:19 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 18:17:19 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 18:17:19 INFO - Using env: {'DISPLAY': ':0', 18:17:19 INFO - 'HOME': '/home/cltbld', 18:17:19 INFO - 'LANG': 'en_US.UTF-8', 18:17:19 INFO - 'LANGUAGE': 'en_US:en', 18:17:19 INFO - 'LOGNAME': 'cltbld', 18:17:19 INFO - 'MAIL': '/var/mail/cltbld', 18:17:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:19 INFO - 'MOZ_NO_REMOTE': '1', 18:17:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:19 INFO - 'NO_EM_RESTART': '1', 18:17:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:19 INFO - 'PWD': '/builds/slave/test', 18:17:19 INFO - 'SHELL': '/bin/bash', 18:17:19 INFO - 'SHLVL': '1', 18:17:19 INFO - 'TERM': 'linux', 18:17:19 INFO - 'TMOUT': '86400', 18:17:19 INFO - 'USER': 'cltbld', 18:17:19 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', 18:17:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:19 INFO - '_': '/tools/buildbot/bin/python'} 18:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:17:19 INFO - Running setup.py (path:/tmp/pip-NDJqFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:17:19 INFO - Running setup.py (path:/tmp/pip-AgxFWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:17:19 INFO - Running setup.py (path:/tmp/pip-BTbghC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:17:19 INFO - Running setup.py (path:/tmp/pip-SqxxLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:17:19 INFO - Running setup.py (path:/tmp/pip-I9bcKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:17:19 INFO - Running setup.py (path:/tmp/pip-Mz4M4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:17:19 INFO - Running setup.py (path:/tmp/pip-JYgy77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:17:19 INFO - Running setup.py (path:/tmp/pip-sItlcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:17:19 INFO - Running setup.py (path:/tmp/pip-0pRwLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:17:19 INFO - Running setup.py (path:/tmp/pip-w0suOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:17:19 INFO - Running setup.py (path:/tmp/pip-VFQ7Bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:17:20 INFO - Running setup.py (path:/tmp/pip-QdbTu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:17:20 INFO - Running setup.py (path:/tmp/pip-bYaNW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:17:20 INFO - Running setup.py (path:/tmp/pip-OxSx8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:20 INFO - Running setup.py (path:/tmp/pip-Xv2iQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:17:20 INFO - Running setup.py (path:/tmp/pip-QwmYbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:17:20 INFO - Running setup.py (path:/tmp/pip-cssGGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:17:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:17:20 INFO - Running setup.py install for manifestparser 18:17:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:17:20 INFO - Running setup.py install for mozcrash 18:17:20 INFO - Running setup.py install for mozdebug 18:17:20 INFO - Running setup.py install for mozdevice 18:17:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:17:20 INFO - Running setup.py install for mozfile 18:17:20 INFO - Running setup.py install for mozhttpd 18:17:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:17:21 INFO - Running setup.py install for mozinfo 18:17:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:17:21 INFO - Running setup.py install for mozInstall 18:17:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:17:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:17:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:17:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:17:21 INFO - Running setup.py install for mozleak 18:17:21 INFO - Running setup.py install for mozlog 18:17:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:17:21 INFO - Running setup.py install for moznetwork 18:17:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:17:21 INFO - Running setup.py install for mozprocess 18:17:21 INFO - Running setup.py install for mozprofile 18:17:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:17:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:17:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:17:21 INFO - Running setup.py install for mozrunner 18:17:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:17:21 INFO - Running setup.py install for mozscreenshot 18:17:22 INFO - Running setup.py install for moztest 18:17:22 INFO - Running setup.py install for mozversion 18:17:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:17:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:17:22 INFO - Cleaning up... 18:17:22 INFO - Return code: 0 18:17:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:22 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')]} 18:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:22 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')]} 18:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:22 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 0x11ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1396a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1539a30>, '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 0x153a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153aca0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', '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 18:17:22 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 18:17:22 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 18:17:22 INFO - Using env: {'DISPLAY': ':0', 18:17:22 INFO - 'HOME': '/home/cltbld', 18:17:22 INFO - 'LANG': 'en_US.UTF-8', 18:17:22 INFO - 'LANGUAGE': 'en_US:en', 18:17:22 INFO - 'LOGNAME': 'cltbld', 18:17:22 INFO - 'MAIL': '/var/mail/cltbld', 18:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:22 INFO - 'MOZ_NO_REMOTE': '1', 18:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:22 INFO - 'NO_EM_RESTART': '1', 18:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:22 INFO - 'PWD': '/builds/slave/test', 18:17:22 INFO - 'SHELL': '/bin/bash', 18:17:22 INFO - 'SHLVL': '1', 18:17:22 INFO - 'TERM': 'linux', 18:17:22 INFO - 'TMOUT': '86400', 18:17:22 INFO - 'USER': 'cltbld', 18:17:22 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', 18:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:22 INFO - '_': '/tools/buildbot/bin/python'} 18:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:17:22 INFO - Running setup.py (path:/tmp/pip-9Ko7IS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:17:22 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)) 18:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:17:22 INFO - Running setup.py (path:/tmp/pip-YNkAtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:17:22 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)) 18:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:17:22 INFO - Running setup.py (path:/tmp/pip-8UrLZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:17:22 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)) 18:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:17:22 INFO - Running setup.py (path:/tmp/pip-gP86nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:17:22 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)) 18:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:17:22 INFO - Running setup.py (path:/tmp/pip-gmrHfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:17:22 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)) 18:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:17:22 INFO - Running setup.py (path:/tmp/pip-UUhQO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:17:22 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)) 18:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:17:22 INFO - Running setup.py (path:/tmp/pip-3reD_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:17:22 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)) 18:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:17:22 INFO - Running setup.py (path:/tmp/pip-1Oyr6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:17:23 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)) 18:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:17:23 INFO - Running setup.py (path:/tmp/pip-0n0N_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:17:23 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)) 18:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:17:23 INFO - Running setup.py (path:/tmp/pip-60weMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:17:23 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)) 18:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:17:23 INFO - Running setup.py (path:/tmp/pip-EKgTOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:17:23 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)) 18:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:17:23 INFO - Running setup.py (path:/tmp/pip-YBU96Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:17:23 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)) 18:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:17:23 INFO - Running setup.py (path:/tmp/pip-ztE9ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:17:23 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)) 18:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:17:23 INFO - Running setup.py (path:/tmp/pip-AGeQiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:17:23 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)) 18:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:23 INFO - Running setup.py (path:/tmp/pip-W6w4vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:17:23 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)) 18:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:17:23 INFO - Running setup.py (path:/tmp/pip-KEP_X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:17:23 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)) 18:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:17:23 INFO - Running setup.py (path:/tmp/pip-0RDL7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:17:23 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)) 18:17:23 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)) 18:17:23 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)) 18:17:23 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)) 18:17:23 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)) 18:17:23 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)) 18:17:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:24 INFO - Downloading blessings-1.6.tar.gz 18:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:17:24 INFO - Installing collected packages: blessings 18:17:24 INFO - Running setup.py install for blessings 18:17:24 INFO - Successfully installed blessings 18:17:24 INFO - Cleaning up... 18:17:25 INFO - Return code: 0 18:17:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:17:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:17:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:17:25 INFO - Reading from file tmpfile_stdout 18:17:25 INFO - Current package versions: 18:17:25 INFO - argparse == 1.2.1 18:17:25 INFO - blessings == 1.6 18:17:25 INFO - blobuploader == 1.2.4 18:17:25 INFO - docopt == 0.6.1 18:17:25 INFO - functools32 == 3.2.3-2 18:17:25 INFO - jsonschema == 2.5.1 18:17:25 INFO - manifestparser == 1.1 18:17:25 INFO - mozInstall == 1.12 18:17:25 INFO - mozcrash == 1.0 18:17:25 INFO - mozdebug == 0.1 18:17:25 INFO - mozdevice == 0.50 18:17:25 INFO - mozfile == 1.2 18:17:25 INFO - mozhttpd == 0.7 18:17:25 INFO - mozinfo == 0.9 18:17:25 INFO - mozleak == 0.1 18:17:25 INFO - mozlog == 3.4 18:17:25 INFO - moznetwork == 0.27 18:17:25 INFO - mozprocess == 0.25 18:17:25 INFO - mozprofile == 0.28 18:17:25 INFO - mozrunner == 6.13 18:17:25 INFO - mozscreenshot == 0.1 18:17:25 INFO - mozsystemmonitor == 0.3 18:17:25 INFO - moztest == 0.8 18:17:25 INFO - mozversion == 1.4 18:17:25 INFO - psutil == 3.1.1 18:17:25 INFO - requests == 1.2.3 18:17:25 INFO - wsgiref == 0.1.2 18:17:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:25 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 0x11ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1396a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1539a30>, '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 0x153a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153aca0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', '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 18:17:25 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 18:17:25 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 18:17:25 INFO - Using env: {'DISPLAY': ':0', 18:17:25 INFO - 'HOME': '/home/cltbld', 18:17:25 INFO - 'LANG': 'en_US.UTF-8', 18:17:25 INFO - 'LANGUAGE': 'en_US:en', 18:17:25 INFO - 'LOGNAME': 'cltbld', 18:17:25 INFO - 'MAIL': '/var/mail/cltbld', 18:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:25 INFO - 'MOZ_NO_REMOTE': '1', 18:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:25 INFO - 'NO_EM_RESTART': '1', 18:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:25 INFO - 'PWD': '/builds/slave/test', 18:17:25 INFO - 'SHELL': '/bin/bash', 18:17:25 INFO - 'SHLVL': '1', 18:17:25 INFO - 'TERM': 'linux', 18:17:25 INFO - 'TMOUT': '86400', 18:17:25 INFO - 'USER': 'cltbld', 18:17:25 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', 18:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:25 INFO - '_': '/tools/buildbot/bin/python'} 18:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:25 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)) 18:17:25 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)) 18:17:25 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)) 18:17:25 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)) 18:17:25 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)) 18:17:25 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)) 18:17:25 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)) 18:17:25 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)) 18:17:25 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)) 18:17:25 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)) 18:17:25 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)) 18:17:25 INFO - Cleaning up... 18:17:25 INFO - Return code: 0 18:17:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11ca1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1396a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153c770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1539a30>, '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 0x153a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153aca0>, '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': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', '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 18:17:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:17:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:17:25 INFO - Using env: {'DISPLAY': ':0', 18:17:25 INFO - 'HOME': '/home/cltbld', 18:17:25 INFO - 'LANG': 'en_US.UTF-8', 18:17:25 INFO - 'LANGUAGE': 'en_US:en', 18:17:25 INFO - 'LOGNAME': 'cltbld', 18:17:25 INFO - 'MAIL': '/var/mail/cltbld', 18:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:25 INFO - 'MOZ_NO_REMOTE': '1', 18:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:25 INFO - 'NO_EM_RESTART': '1', 18:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:25 INFO - 'PWD': '/builds/slave/test', 18:17:25 INFO - 'SHELL': '/bin/bash', 18:17:25 INFO - 'SHLVL': '1', 18:17:25 INFO - 'TERM': 'linux', 18:17:25 INFO - 'TMOUT': '86400', 18:17:25 INFO - 'USER': 'cltbld', 18:17:25 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', 18:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:25 INFO - '_': '/tools/buildbot/bin/python'} 18:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:17:25 INFO - Cleaning up... 18:17:25 INFO - Return code: 0 18:17:25 INFO - Running post-action listener: _resource_record_post_action 18:17:25 INFO - Running post-action listener: _start_resource_monitoring 18:17:25 INFO - Starting resource monitoring. 18:17:25 INFO - [mozharness: 2017-05-12 01:17:25.726116Z] Finished create-virtualenv step (success) 18:17:25 INFO - [mozharness: 2017-05-12 01:17:25.726621Z] Running install step. 18:17:25 INFO - Running pre-action listener: _resource_record_pre_action 18:17:25 INFO - Running main action method: install 18:17:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:17:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:17:25 INFO - Reading from file tmpfile_stdout 18:17:25 INFO - Detecting whether we're running mozinstall >=1.0... 18:17:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:17:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:17:26 INFO - Reading from file tmpfile_stdout 18:17:26 INFO - Output received: 18:17:26 INFO - Usage: mozinstall [options] installer 18:17:26 INFO - Options: 18:17:26 INFO - -h, --help show this help message and exit 18:17:26 INFO - -d DEST, --destination=DEST 18:17:26 INFO - Directory to install application into. [default: 18:17:26 INFO - "/builds/slave/test"] 18:17:26 INFO - --app=APP Application being installed. [default: firefox] 18:17:26 INFO - mkdir: /builds/slave/test/build/application 18:17:26 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'] 18:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:17:41 INFO - Reading from file tmpfile_stdout 18:17:41 INFO - Output received: 18:17:41 INFO - /builds/slave/test/build/application/firefox/firefox 18:17:41 INFO - Running post-action listener: _resource_record_post_action 18:17:41 INFO - [mozharness: 2017-05-12 01:17:41.928855Z] Finished install step (success) 18:17:41 INFO - [mozharness: 2017-05-12 01:17:41.928997Z] Running run-tests step. 18:17:41 INFO - Running pre-action listener: _resource_record_pre_action 18:17:41 INFO - Running main action method: run_tests 18:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:17:41 INFO - Python 2.7.3 18:17:41 INFO - Return code: 0 18:17:41 INFO - grabbing minidump binary from tooltool 18:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:41 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 0x1539a30>, '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 0x153a7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x153aca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:17:41 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 18:17:41 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 18:17:41 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 18:17:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:17:42 INFO - Return code: 0 18:17:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:17:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:17:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:17:42 INFO - ENV: RUST_BACKTRACE is now 1 18:17:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:17:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:17:42 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/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 18:17:42 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/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --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 18:17:42 INFO - Using env: {'DISPLAY': ':0', 18:17:42 INFO - 'HOME': '/home/cltbld', 18:17:42 INFO - 'LANG': 'en_US.UTF-8', 18:17:42 INFO - 'LANGUAGE': 'en_US:en', 18:17:42 INFO - 'LOGNAME': 'cltbld', 18:17:42 INFO - 'MAIL': '/var/mail/cltbld', 18:17:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:17:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:42 INFO - 'MOZ_NO_REMOTE': '1', 18:17:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:42 INFO - 'NO_EM_RESTART': '1', 18:17:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:42 INFO - 'PWD': '/builds/slave/test', 18:17:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:17:42 INFO - 'RUST_BACKTRACE': '1', 18:17:42 INFO - 'SHELL': '/bin/bash', 18:17:42 INFO - 'SHLVL': '1', 18:17:42 INFO - 'TERM': 'linux', 18:17:42 INFO - 'TMOUT': '86400', 18:17:42 INFO - 'USER': 'cltbld', 18:17:42 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436', 18:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:42 INFO - '_': '/tools/buildbot/bin/python'} 18:17:42 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/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 18:17:42 INFO - mozversion application_buildid: 20170512003303 18:17:42 INFO - mozversion application_changeset: 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc 18:17:42 INFO - mozversion application_display_name: Nightly 18:17:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:17:42 INFO - mozversion application_name: Firefox 18:17:42 INFO - mozversion application_remotingname: firefox 18:17:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:17:42 INFO - mozversion application_vendor: Mozilla 18:17:42 INFO - mozversion application_version: 55.0a1 18:17:42 INFO - mozversion platform_buildid: 20170512003303 18:17:42 INFO - mozversion platform_changeset: 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc 18:17:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:17:42 INFO - mozversion platform_version: 55.0a1 18:17:42 INFO - using testdate: 1494551862 18:17:42 INFO - actual date: 1494551862 18:17:42 INFO - starting webserver on 'localhost:47280' 18:17:42 INFO - SUITE-START | Running 2 tests 18:17:42 INFO - TEST-START | dromaeo_css 18:17:42 INFO - operating with platform_type : linux_ 18:17:42 INFO - Initialising browser for dromaeo_css test... 18:17:42 INFO - TEST-INFO | started process 25550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVc1CX_/profile http://localhost:47280/getInfo.html) 18:17:46 INFO - PID 25550 | __metrics Screen width/height:1600/1200 18:17:46 INFO - PID 25550 | colorDepth:24 18:17:46 INFO - PID 25550 | Browser inner width/height: 1024/695 18:17:46 INFO - PID 25550 | __metrics 18:17:48 INFO - TEST-INFO | 25550: exit 0 18:17:48 INFO - Browser initialized. 18:17:48 INFO - Running cycle 1/1 for dromaeo_css test... 18:17:48 INFO - TEST-INFO | started process 25720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVc1CX_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:18:00 INFO - PID 25720 | RSS: Main: 154796032 18:18:00 INFO - PID 25720 | 18:21:05 INFO - PID 25720 | Cycle 1(1): loaded http://localhost:47280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47280/tests/dromaeo/cssquery-ext.html) 18:21:07 INFO - PID 25720 | RSS: Main: 164990976 18:21:07 INFO - PID 25720 | 18:24:09 INFO - PID 25720 | Cycle 1(1): loaded http://localhost:47280/tests/dromaeo/cssquery-ext.html (next: http://localhost:47280/tests/dromaeo/cssquery-jquery.html) 18:24:10 INFO - PID 25720 | RSS: Main: 161157120 18:24:10 INFO - PID 25720 | 18:27:11 INFO - PID 25720 | Cycle 1(1): loaded http://localhost:47280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47280/tests/dromaeo/cssquery-mootools.html) 18:27:12 INFO - PID 25720 | RSS: Main: 168632320 18:27:12 INFO - PID 25720 | 18:30:14 INFO - PID 25720 | Cycle 1(1): loaded http://localhost:47280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47280/tests/dromaeo/cssquery-prototype.html) 18:30:14 INFO - PID 25720 | RSS: Main: 161050624 18:30:14 INFO - PID 25720 | 18:33:17 INFO - PID 25720 | Cycle 1(1): loaded http://localhost:47280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47280/tests/dromaeo/cssquery-yui.html) 18:33:18 INFO - PID 25720 | RSS: Main: 167014400 18:33:18 INFO - PID 25720 | 18:36:20 INFO - PID 25720 | Cycle 1(1): loaded http://localhost:47280/tests/dromaeo/cssquery-yui.html (next: http://localhost:47280/tests/dromaeo/cssquery-dojo.html) 18:36:20 INFO - PID 25720 | RSS: Main: 169639936 18:36:20 INFO - PID 25720 | 18:36:20 INFO - PID 25720 | __start_tp_report 18:36:20 INFO - PID 25720 | _x_x_mozilla_page_load 18:36:20 INFO - PID 25720 | _x_x_mozilla_page_load_details 18:36:20 INFO - PID 25720 | |i|pagename|runs| 18:36:20 INFO - PID 25720 | |0;dojo.html;2735.1110888961093;2749.243957911574;2767.958480622791;2768.1695491352593;2783.6937936826957;5073.264376665391;5246.134387826009;5259.395169555502;5287.180487024508;5309.619498930277;5222.399424066233;5233.188855727369;5247.396549396821;5289.180177072551;5327.946720532794;4402.380373149698;4653.488116307203;4680.5787479126875;4680.999999999992;4706.458757242909;4722.97638511807;4756.548127927841;4770.689905156171;4777.976110119462;4779.378680771495;4554.954450455486;4639.698419602715;4645.279981602857;4702.506236845116;4713.175194340976;4686.015936653273;4691.601213896823;4696.201645720235;4701.271302948015;4726.7400292983875;4609.700369476007;4634.745089020103;4665.393498845162;4667.066586682677;4688.156131896258;5102;5113.667611605234;5159.22611608258;5214.374275086976;5221.39953905302;5484.588655850827;5488.670679759227;5502.58730595203;5503.284573005483;5516.586256030814;5515.062439385274;5517.944820551824;5520.868222014477;5526.06056970312;5541.722913854291;5094.719790411563;5126.333576635088;5145.2024936134585;5147.382314122329;5148;5591.552675785927;5651.237082993744;5652.152177173457;5655.0386434306265;5656.717164141776;5387.649802762808;5419.430959749248;5426.457354264542;5458.645188062763;5459.945400546023;5625.240592520039;5745.2818397700285;5760.711964401847;5765.135229715576;5767.8558036049435;5617.129344951457;5629.746661400247;5631.662100273997;5637;5647.068233741386;5401.216823560561;5647.632903861236;5652.265205523256;5672.8865422691315;5680.914786278209;4301.827926882889;4305.634021108178;4380.4305440292555;4397.890052748643;4409.36064270679;3830.3105441020325;3831.252905683365;3851.78815165163;3867.0332416895776;3875.418687196943;4914.213725803854;4917.532834380728;4919.1391506486225;4924.679895806761;4948.406191257072;5588.944110558924;5661.801836935688;5673.262475878109;5681.77272909079;5761.625494342854;4827.734474603861;4836.613070954315;4846.684965477232;4847.200211965057;4855;5022.799088036438;5030.170021946411;5130.384353877558;5145.768440420115;5153.896922061538;5308.150695888639;5356.250124982505;5363.302770639792;5365.758540865592;5370.167624018283;5703.8003669873015;5764.308283006066;5768.53851691872;5770.798022069207;5783.913241301299;5135.589152867837;5266.07843627356;5323.760430780547;5325.307709997675;5331.733413329395;5580.609357344947;5636.323641163087;5676.886462270814;5677;5683.488486036276;5698.487136157766;5720.713964301852;5728.369879313355;5729.2551968245525;5730.197772311796;5374.946250537445;5501.944980550304;5517.310336207974;5520.723963801714;5544.085225937675;5415.756290966995;5487.780488780404;5569.192467092168;5577.609567330248;5583.218349431002;5419.214213939035;5451.155070964007;5473.124300111963;5478.945210547843;5496.835094947158;5524.861878453071;5608.046632072476;5609.691466969356;5626.227946575648;5654.745536450787;5303.761330740049;5380.569554435558;5405.378381486022;5472.863178420572;5496.230527726041 18:36:20 INFO - PID 25720 | |1;ext.html;668.5787953589238;722.5484072454715;743.6281859070463;1005.6832097889169;1012.6354512375548;32901.17747056322;33814.66185338146;34105.488417673725;34138.31723365531;34196.316073678514;35249.823750881274;35528.64471355286;35728.82135589318;35734.2853142937;35772.821135894286;6734.966325168391;6910.101686780724;6993.720251189946;7047.89428158578;7059.788206353817;6996.3003699630135;7035.296470352975;7079.85840283194;7093.645317734118;7100.005999160122;7052.753153639624;7087.503874728771;7119.074520312352;7131.500794944356;7139.785806425815;7013.789586312419;7069.681864316092;7092.078029856111;7099.077119974396;7102.751403700846;6967.93032069683;6999.790006299819;7028.19175794785;7035.0150978863;7047.43620510358;32534.837325813456;32754.836225818955;32853.83573082143;32898.17754556155;32908.341833163206;3037.255872311298;3061.586685797411;3065.4635438798346;3066.4940284852973;3070.3091804344067;24311.756882431127;24508.26475205747;24562.631560526606;24648.383790405205;24754;3167.889123880653;3179.586653735023;3203.19920019995;3234.304624505719;3236.2394837213237;137910.31044844812;141038.29480852632;141437;146588;151953.9999999989;40669.59330406717;40783.796081019405;40798.38802417907;41112;41158;42519.57480425156;42750.78624606857;42785;42837.35743963843;44293.33559996603;11784.116191285688;11815.940920295343;11863.940680296544;11872.40637968098;11885.940570297093;9084.40951338161;9131.178193962574;9158.129977652112;9181.449113053239;9191.678291259774;13004.284764337863;13123.278219698008;13184.538541151014;13202.537911173064;13346.46614135443;5397.2443857859935;5447.591430642638;5492.835214943558;5494.80768173112;5503.642263252876;865.2342676731138;914.2253261351766;914.3142643017736;919.8252332057021;951.5194826612517;20476.965522716993;21296.78703212979;21687.34937951864;21750;21961.67057494139;993.9353941993747;997.5361456922566;1003.0270637481631;1007.3502590829021;1022.616518805448;11099.389533575732;11461;11464.713382165346;11494.88505114955;11537.653870383901;168801;168806;169164;169259;169508.1524592369;40480.59519404768;40728.38907416391;40756.38865417021;40952.54284742865;41011.7949410257;1191.7854786138578;1235.178606226867;1244.6266120164096;1244.925304481734;1248.17620370555;19811;20801.687974680088;21559.05550994016;21633;21760.673589895847;30506.389872201988;33714;34897.30205395928;34947.30105397827;35016.64983350134;158399;159364;159380;159923;160685;30535.847320763252;30558.388832222787;30558.694413056473;30957.380852383278;31067.533986990664;36013.45979810358;36156.63843361638;37065.258694826494;37168.81415593013;37263.44104838484;27265;27575.31061723473;27829.30426739267;28366;29122.56316155217;27370.726292737614;27905.44189116247;28028;28467;29472.705272946994;30940.845295773375;31015.844920775253;31164.597593107912;31327.53008704917;31561.52657710182;25019.374515637253;26400.867995659897;26500;27218.455630886874;27933.301667458476;20686.275980340615;22525.324240272817;22551.661725074464;22652.093916243164;22837.65743513882 18:36:20 INFO - PID 25720 | |2;jquery.html;412.7853516171589;416.25698128840025;422.1872894677746;436.818720231104;443.3283575383295;13644.113132646371;14452.494162704308;17068.743968840477;17481.300747970065;17524.82475175248;16403.917980410082;16886.240119194634;16892.915535422337;17149.74275385867;17163.656726865487;5385.21914322424;5395.81114660987;5565.526930210916;5572.359178694442;5615.550755939515;5458.099413596752;5533.446655334475;5571.303587051619;5577.191307260465;5580.107182850725;5066.392032956051;5556.305461817273;5566.916496252539;5567.192757050226;5573.749181286831;5377.784888604451;5524.033294173503;5550.750216240279;5576.518449290088;5590.18942253375;5074.238864170367;5077.289179514871;5110.872228194287;5112.335396398482;5119.718415487184;21734.673979890154;21940.89029554842;22195.778042219696;22303.330900073022;22374;1549.3028137338242;1596.0343991884858;1596.4173076826992;1597.768323593084;1598.3047374392177;14553.199574023425;14642.194679292634;15008.699826003529;15056.096634201984;15064.924675376662;2036.6334059869218;2106.262808017197;2109.377733568601;2128.6062078515524;2134.263679030732;87597;93095;93770.5311473445;94524;94551.52724236334;10667.679969600924;10861.34831910088;11037.037770799752;11172.385518796382;11406.315621062597;15237.771433428508;15529.301181446863;15554.844451555566;15603.297851596706;15604.375824967101;7118.29709424813;7326.413886889036;7330.450216233804;7475.102987641518;7490.063742032246;6506.479481641457;6622.205335359691;6764.797056088325;6797.898031529531;6807;6711.463082953352;6791.45668346541;6848.897266541006;6873.48448866327;6944.340287672663;1989.5424052467724;2012.9798702012793;2045.7545094588745;2046.8567200295836;2146.1522698534304;824.8515267251832;854.1117238072335;878.4070752242211;884.91150884911;884.9911500885038;16454.83545164557;17101.315947361967;17363.565910852078;17722.734158987627;17728;871.8212766382876;877.2850127146355;880.2429910277284;884.6063501741663;894.9239314658327;9062.456252624732;9395.107464790834;9685.806283874424;9704.9029509704;9784.315097943218;333739;335207;337717;345144;345557;76246.2375376239;77201.22798771941;81612.18387816046;82030.58984705039;85378.57310713407;1066.706655669697;1103.167108832826;1114.6823155400673;1114.9331040137617;1122.9157813164045;17341.306347745947;17722.20250088775;18176.182071807067;18317.725234121233;18585.81414185841;37624.811875940446;37760.433593496666;38029.61970380261;38066.04834879039;39871.40192897051;48852.5114748848;48920;49051.50948490612;49094.790734416325;49195.26207106968;8248.381371397289;8267.793305167419;8351.41540092212;8430.072692003998;8594.613242403982;11950.760984780429;12167;12225.388730563258;12531.74936501283;13035.804462932874;10086.445245511568;10471.842922356323;10496.317739346918;11081.501332439899;11301.886981130083;10390.688279351632;10494.422806745702;10549.367037977747;10554.313969591953;10650.73373165677;11274.492647830702;11336.433178341214;11378.886211138113;11498.310101393943;11726.824097638371;8285.171482851667;8559.443636163629;8656.870146947675;8692.826143476968;8706.347023973354;10610.363378197333;10897;10937.671869843918;11141.777164456504;11266.83099753488 18:36:20 INFO - PID 25720 | |3;mootools.html;1263.4946021591363;1306.1053178572672;1311.9212847229167;1312.7440149170905;1319.5183757928353;9734;10164.339317944337;10176.08415242628;10455.686329410111;10788.622398216065;10570.101541368973;10728.78542429151;10758.139348852093;10762.192835537346;10763.192760542972;2212.6902233687297;2251.279590531031;2259.4690247791837;2267.9886600566974;2273.3634582316977;2190.518086021073;2255.2670382125793;2262.8416010879246;2265.2977576951116;2267.240474441056;2225.4547635829163;2225.4547635829244;2277.7038984931937;2279.908803647852;2286.085565773687;2187.58435897179;2203.636399993999;2236.0943817753837;2245.854019488728;2247.381969958258;1826.1690930626532;1902.3627084926427;2198.362474882282;2210.701555290031;2214.3135627955226;10253.025962533547;10372.273940824145;10377.11794497461;10380.948095259475;10412.739681508023;5667.518260947824;5806.970965145189;5878.735456904449;5882.029465138247;5914.704264786744;3306.7354611631254;3457.9308413831836;3472.5485686860548;3525.4006818840858;3555.3600351936643;1067.4555976451988;1090.7327704712395;1123.309164863603;1147.5868687272575;1157.1899670230873;14998.100113993087;15118.546443606709;15149.772753408597;15295.770563441558;15321.540353789293;4487.842925497592;4734.26618874075;4852.272159176152;4890.682105663121;4915.26271059344;10895.128389728803;10900.563977440814;10908.34549927007;10909.18181136418;10954.726131846768;5511.972440137773;5518.33779946401;5522.0336441122645;5564.109742441271;5568.136938774496;4916.532929371704;5129.923051154161;5155.845324640267;5176.430592634807;5186.040582492251;3863.2466668999277;3966.8413263469715;3977.264206121819;4018.8593399230886;4077.041895154636;1145.570411095839;1157.4907040901976;1162.604714397109;1167.8948894599528;1173.3370645585217;669.6885948034187;686.9210040845267;688.1398252184769;707.4411215139982;709.0888208651858;5028.949710502849;5125.64120511568;5152.536271735562;5289.841304760864;5297.8145764898045;523.9476052394806;534.7593582887716;537.196890648483;537.2076187623303;537.7577795292885;3235.385276797401;3255.9837200813845;3275.606927168755;3278.2951665392056;3366.32673465303;12781;12864.421101050288;13308.73382532344;13415;13519.391627376595;13238.073334866467;13308.334583270798;13313.201207927556;13315.40080696371;13335.466581336832;7220.783376498714;7519.360854327334;7526.661300241502;7546.962265188639;7556.4710470266555;5887.646741195542;5902.2327097477055;5909.52723782105;6002.129691194665;6103.328633850184;11542.94228528852;11890.940545297219;11915.2255103418;11941.462634181657;12054;11964.401779910795;12208.877911220774;12320.876791231973;12328.876711233132;12333.383330833602;8202.384821138558;8209.71266005687;8232.217939295757;8241.093479717107;8305.086440491421;9615.23078153732;9681.66114186;9729.416235025921;9743.56153973087;9745.756356091155;7686.116096648733;7800.6099695016155;7865.528068315919;7924.1283458820635;8060.03279606451;7760.14638389788;7780.805479863048;7880;8057.435979481615;8102;7521.8871716923195;7615.65729542183;7676.692932282869;7705.267999540035;7715.344195743424;4801.375821143229;5327.286771484905;5338.439463856239;5523.7790488380015;5615.578831587565;5415.323084614423;5455.61810673265;5490.615656903979;5519.2824932758485;5642.887142257214 18:36:20 INFO - PID 25720 | |4;prototype.html;362.1814698780756;367.9981600091999;369.5214696967426;378.5041595509882;386.45123924027877;5370.7046112463795;5555.33339998001;5563.471470210334;5564.888702225953;5579.553635709143;5345.33183352081;5448.727563621813;5449.100898351777;5470.452954704538;5493.752781124849;4305.504866940295;4308.138372325548;4312.374705667677;4322.697411181219;4326.783660816946;4178.227027999815;4251.192273468031;4266.424032755584;4316.704988503452;4322.459692538433;4215.283401821683;4233.470816147981;4241.639460645833;4247.25673007224;4251.723637963538;4236.809343579531;4246.171996460692;4249.366791393376;4250.702450828443;4253.1706317268145;3765.021094515418;3830.8276127574327;3834.616538346171;3842.5965273646425;3856.151646637735;5350.8127215547265;5355.7857685692525;5364.973175134139;5383.43473935235;5394.838154855322;5056.140456122468;5058.797648094109;5068.315777370081;5068.69587824728;5082.720450375228;5595.38450770415;5741.425857414267;5747.367789543188;5769.134629805562;5816.912746308809;4314.935275970863;4316.848910288125;4320.1575692739925;4328.588784065509;4334.934975975363;5868.383819698913;6059.121427393047;6066.272047354346;6123.928312545287;6170.81487555374;4181.330987042059;4189.350650649154;4199.622034016953;4204.180184863983;4205.095904380573;4271.974726065784;4281.207976524353;4282.143571285756;4286.764227967492;4300.0969796343115;4775.307580400892;4862.17343051682;4878.707277563358;4885.120678277873;4906.460289368167;5734.7132643368495;5763.991301522301;5781.386633354154;5808.5062769665055;5809.651420914759;1563.4606060908968;1582.8179759327825;1584.382090984517;1589.1577463944127;1598.6642805010845;1109.8501702270253;1113.8551988241477;1121.8149005414016;1126.4367816091954;1142.6572028391615;5039.244113383022;5045.495450454925;5049.192129259301;5060.645754797202;5064.392272927273;5943.762249510058;5994.340622531518;6012.617098067381;6022.2171117754415;6032.547558933097;4897.461279259279;5003.549680528697;5024.271480635288;5044.2937988681615;5047.470015648304;3161.2571045804216;3178.2848859007;3179.7440011195913;3192.9680703193135;3208.262099717078;5369.624126311199;5473.9452605474235;5540.501354878081;5553.666779993213;5571.275734154615;6125.540584456184;6125.663088530174;6132.5707200495535;6153.538484613582;6174.598651087755;5536.363318218457;5540.529055030287;5548.889022219533;5550.250716153349;5553.111502159635;5930.258717660293;5951.940480595139;5992.67040312787;6009.609375390585;6043.909341359971;5706.629069110494;5860.648361098348;5875.706214689334;5888.764449421975;5909.793157239476;5525.502704756591;5573.6098473106495;5576.944230557642;5585;5614.438556144353;4021.4973128358956;4045.534763502235;4051.2505186540584;4057.797110144422;4070.4504891839224;5909.970450147722;5910.202122713378;6018.8194354169445;6061;6073;5816.970915145397;5825.330087039875;5825.854353641193;5840.532757379485;5841.561882858888;5702.600817942704;5731.455511726379;5753.079507278815;5803.245578074823;5826.067829147316;5698.686572238566;5738.598298119258;5752.654840709571;5770.192173095686;5798.362180160263;5863.296404431496;5867.413258674099;5876.882462350814;5884.382139875423;5887.322957859901;5544.861378465571;5671.347795003628;5687.971560142173;5700.657960522382;5701.945140149086 18:36:20 INFO - PID 25720 | |5;yui.html;731.2687312687312;749.718855429214;756.3117563017655;764.4304992780379;768.2202564397138;12242.143049986504;12702.872971270284;13271.33643317834;14192.07751496152;14200.431982720691;14778.482753103644;14888.181150036744;15436.228188590581;15490.845091549081;15515.767263491029;858.3347905373323;870.316801310971;873.5632183908046;873.978150546235;875.0374587953232;879.3053487744673;881.7531091294447;883.9734807955772;884.3941899798658;887.414306557672;923.376720713519;925.0148591749798;928.5635751196927;930.8231436027168;932.4778124250407;910.7131253655077;919.3013309884469;919.517253441945;921.7234829551142;921.7511271956567;677.0926957876469;678.4572342126279;683.4976292425114;684.8596037812237;685.5098604497808;13723.862761372358;13883.4446622135;13901.374438150307;13976.091554049057;14047.859521404758;15414.614634634112;15604.29780659873;15708.214589270605;15895.52313430599;15948.122853243067;11873.762524749543;11918.033524468452;12092.758144837055;12137.089718271165;12189.69525761863;2881.942361152765;2889.8699558519916;2907.4911890419094;2908.5200941844782;2917.3873486567845;62881.05678414782;64627.67686161586;65318;65411.345886541;65663.67168164176;12373.257604543756;12610.432530536147;12649.87350126487;12681.492740290285;12724.872751272369;22014.33956981261;22042.669359959615;22386.776132238796;22482.775172248068;22659;6069.211002569726;6256.624602523863;6269.059641053878;6325.778597749057;6413.839654008594;3014.216303761038;3062.693730626964;3077.8307193104592;3083.768717346208;3101.98449007758;3415.419378705626;3507.9123021924656;3511.0695665648623;3544.61009288978;3640.453931910182;717.103620474407;718.321186478783;725.9528130671489;726.8655298769745;726.920038795732;582.4612233683825;590.9881802364015;603.8309273403454;607.7386723708847;620.4942971478231;9824.557894894748;10519.84220236697;10960.945195273973;10966.451677416097;10984.395858227874;623.8752249550108;626.1421852062613;630.6090224061112;631.3938618925882;631.4664108828033;4379.605835474759;4546.318052292117;4574.885627859264;4707.764611769398;4740.407449068866;54889.72555137279;55515.44484555103;55791.44208557944;57663.42336576664;61778.382216178165;48344.7582762091;49556;50413.747931260106;51176.208832690674;51976.22035669468;46780.298295525594;47764.5223547767;48003.75998119987;48560;48701.02597948021;10486.947565262124;11292.491837867152;11459.598914037968;11477.48351324209;11570.132240081859;24797.380065498506;25207.36981575475;25408.237752867444;25517.61723574111;26178.08376706806;30637.540436893018;30648.846755766077;30654.386912262074;30789;31507.21231969219;13831.170129792245;13845.584632461043;14122.152670839783;14242.643933901736;14407.06354086981;15403.306851191948;15721.842781572037;16020.439284624983;16342.182890855647;16381.870356853533;13620.250886201355;15082.321295541507;15314.770278445609;15325.693486130438;15734.134622595868;14753.778693319824;14970.700585988438;15084.698306034037;15126;15336;13857.445702172203;13872.167669939836;13898.23559704226;13999.930000349934;14019.579412617637;10514.158867290751;10830;10868.456577171268;10923.508442120283;11099.833502497631;11288.322700637988;11763.176577639482;11862.347570883685;11934.22427542207;12014.399280036137 18:36:20 INFO - PID 25720 | __end_tp_report 18:36:20 INFO - PID 25720 | __start_cc_report 18:36:20 INFO - PID 25720 | _x_x_mozilla_cycle_collect,353 18:36:20 INFO - PID 25720 | __end_cc_report 18:36:20 INFO - PID 25720 | __startTimestamp1494552980372__endTimestamp 18:36:20 INFO - PID 25720 | 18:36:20 INFO - PID 25720 | ------- Summary: start ------- 18:36:20 INFO - PID 25720 | Number of tests: 6 18:36:20 INFO - PID 25720 | 18:36:20 INFO - PID 25720 | [#0] dojo.html Cycles:165 Average:5152.22 Median:5356.25 stddev:621.51 (11.6%) stddev-sans-first:593.78 18:36:20 INFO - PID 25720 | Values: 2735.1 2749.2 2768.0 2768.2 2783.7 5073.3 5246.1 5259.4 5287.2 5309.6 5222.4 5233.2 5247.4 5289.2 5327.9 4402.4 4653.5 4680.6 4681.0 4706.5 4723.0 4756.5 4770.7 4778.0 4779.4 4555.0 4639.7 4645.3 4702.5 4713.2 4686.0 4691.6 4696.2 4701.3 4726.7 4609.7 4634.7 4665.4 4667.1 4688.2 5102.0 5113.7 5159.2 5214.4 5221.4 5484.6 5488.7 5502.6 5503.3 5516.6 5515.1 5517.9 5520.9 5526.1 5541.7 5094.7 5126.3 5145.2 5147.4 5148.0 5591.6 5651.2 5652.2 5655.0 5656.7 5387.6 5419.4 5426.5 5458.6 5459.9 5625.2 5745.3 5760.7 5765.1 5767.9 5617.1 5629.7 5631.7 5637.0 5647.1 5401.2 5647.6 5652.3 5672.9 5680.9 4301.8 4305.6 4380.4 4397.9 4409.4 3830.3 3831.3 3851.8 3867.0 3875.4 4914.2 4917.5 4919.1 4924.7 4948.4 5588.9 5661.8 5673.3 5681.8 5761.6 4827.7 4836.6 4846.7 4847.2 4855.0 5022.8 5030.2 5130.4 5145.8 5153.9 5308.2 5356.3 5363.3 5365.8 5370.2 5703.8 5764.3 5768.5 5770.8 5783.9 5135.6 5266.1 5323.8 5325.3 5331.7 5580.6 5636.3 5676.9 5677.0 5683.5 5698.5 5720.7 5728.4 5729.3 5730.2 5374.9 5501.9 5517.3 5520.7 5544.1 5415.8 5487.8 5569.2 5577.6 5583.2 5419.2 5451.2 5473.1 5478.9 5496.8 5524.9 5608.0 5609.7 5626.2 5654.7 5303.8 5380.6 5405.4 5472.9 5496.2 18:36:20 INFO - PID 25720 | 18:36:20 INFO - PID 25720 | [#1] ext.html Cycles:180 Average:30573.08 Median:17364.71 stddev:40707.03 (234.4%) stddev-sans-first:40759.29 18:36:20 INFO - PID 25720 | Values: 668.6 722.5 743.6 1005.7 1012.6 32901.2 33814.7 34105.5 34138.3 34196.3 35249.8 35528.6 35728.8 35734.3 35772.8 6735.0 6910.1 6993.7 7047.9 7059.8 6996.3 7035.3 7079.9 7093.6 7100.0 7052.8 7087.5 7119.1 7131.5 7139.8 7013.8 7069.7 7092.1 7099.1 7102.8 6967.9 6999.8 7028.2 7035.0 7047.4 32534.8 32754.8 32853.8 32898.2 32908.3 3037.3 3061.6 3065.5 3066.5 3070.3 24311.8 24508.3 24562.6 24648.4 24754.0 3167.9 3179.6 3203.2 3234.3 3236.2 137910.3 141038.3 141437.0 146588.0 151954.0 40669.6 40783.8 40798.4 41112.0 41158.0 42519.6 42750.8 42785.0 42837.4 44293.3 11784.1 11815.9 11863.9 11872.4 11885.9 9084.4 9131.2 9158.1 9181.4 9191.7 13004.3 13123.3 13184.5 13202.5 13346.5 5397.2 5447.6 5492.8 5494.8 5503.6 865.2 914.2 914.3 919.8 951.5 20477.0 21296.8 21687.3 21750.0 21961.7 993.9 997.5 1003.0 1007.4 1022.6 11099.4 11461.0 11464.7 11494.9 11537.7 168801.0 168806.0 169164.0 169259.0 169508.2 40480.6 40728.4 40756.4 40952.5 41011.8 1191.8 1235.2 1244.6 1244.9 1248.2 19811.0 20801.7 21559.1 21633.0 21760.7 30506.4 33714.0 34897.3 34947.3 35016.6 158399.0 159364.0 159380.0 159923.0 160685.0 30535.8 30558.4 30558.7 30957.4 31067.5 36013.5 36156.6 37065.3 37168.8 37263.4 27265.0 27575.3 27829.3 28366.0 29122.6 27370.7 27905.4 28028.0 28467.0 29472.7 30940.8 31015.8 31164.6 31327.5 31561.5 25019.4 26400.9 26500.0 27218.5 27933.3 20686.3 22525.3 22551.7 22652.1 22837.7 18:36:20 INFO - PID 25720 | 18:36:20 INFO - PID 25720 | [#2] jquery.html Cycles:180 Average:24201.34 Median:37692.62 stddev:57058.98 (151.4%) stddev-sans-first:57191.09 18:36:20 INFO - PID 25720 | Values: 412.8 416.3 422.2 436.8 443.3 13644.1 14452.5 17068.7 17481.3 17524.8 16403.9 16886.2 16892.9 17149.7 17163.7 5385.2 5395.8 5565.5 5572.4 5615.6 5458.1 5533.4 5571.3 5577.2 5580.1 5066.4 5556.3 5566.9 5567.2 5573.7 5377.8 5524.0 5550.8 5576.5 5590.2 5074.2 5077.3 5110.9 5112.3 5119.7 21734.7 21940.9 22195.8 22303.3 22374.0 1549.3 1596.0 1596.4 1597.8 1598.3 14553.2 14642.2 15008.7 15056.1 15064.9 2036.6 2106.3 2109.4 2128.6 2134.3 87597.0 93095.0 93770.5 94524.0 94551.5 10667.7 10861.3 11037.0 11172.4 11406.3 15237.8 15529.3 15554.8 15603.3 15604.4 7118.3 7326.4 7330.5 7475.1 7490.1 6506.5 6622.2 6764.8 6797.9 6807.0 6711.5 6791.5 6848.9 6873.5 6944.3 1989.5 2013.0 2045.8 2046.9 2146.2 824.9 854.1 878.4 884.9 885.0 16454.8 17101.3 17363.6 17722.7 17728.0 871.8 877.3 880.2 884.6 894.9 9062.5 9395.1 9685.8 9704.9 9784.3 333739.0 335207.0 337717.0 345144.0 345557.0 76246.2 77201.2 81612.2 82030.6 85378.6 1066.7 1103.2 1114.7 1114.9 1122.9 17341.3 17722.2 18176.2 18317.7 18585.8 37624.8 37760.4 38029.6 38066.0 39871.4 48852.5 48920.0 49051.5 49094.8 49195.3 8248.4 8267.8 8351.4 8430.1 8594.6 11950.8 12167.0 12225.4 12531.7 13035.8 10086.4 10471.8 10496.3 11081.5 11301.9 10390.7 10494.4 10549.4 10554.3 10650.7 11274.5 11336.4 11378.9 11498.3 11726.8 8285.2 8559.4 8656.9 8692.8 8706.3 10610.4 10897.0 10937.7 11141.8 11266.8 18:36:20 INFO - PID 25720 | 18:36:20 INFO - PID 25720 | [#3] mootools.html Cycles:180 Average:6296.29 Median:3465.24 stddev:4076.86 (117.7%) stddev-sans-first:4070.76 18:36:20 INFO - PID 25720 | Values: 1263.5 1306.1 1311.9 1312.7 1319.5 9734.0 10164.3 10176.1 10455.7 10788.6 10570.1 10728.8 10758.1 10762.2 10763.2 2212.7 2251.3 2259.5 2268.0 2273.4 2190.5 2255.3 2262.8 2265.3 2267.2 2225.5 2225.5 2277.7 2279.9 2286.1 2187.6 2203.6 2236.1 2245.9 2247.4 1826.2 1902.4 2198.4 2210.7 2214.3 10253.0 10372.3 10377.1 10380.9 10412.7 5667.5 5807.0 5878.7 5882.0 5914.7 3306.7 3457.9 3472.5 3525.4 3555.4 1067.5 1090.7 1123.3 1147.6 1157.2 14998.1 15118.5 15149.8 15295.8 15321.5 4487.8 4734.3 4852.3 4890.7 4915.3 10895.1 10900.6 10908.3 10909.2 10954.7 5512.0 5518.3 5522.0 5564.1 5568.1 4916.5 5129.9 5155.8 5176.4 5186.0 3863.2 3966.8 3977.3 4018.9 4077.0 1145.6 1157.5 1162.6 1167.9 1173.3 669.7 686.9 688.1 707.4 709.1 5028.9 5125.6 5152.5 5289.8 5297.8 523.9 534.8 537.2 537.2 537.8 3235.4 3256.0 3275.6 3278.3 3366.3 12781.0 12864.4 13308.7 13415.0 13519.4 13238.1 13308.3 13313.2 13315.4 13335.5 7220.8 7519.4 7526.7 7547.0 7556.5 5887.6 5902.2 5909.5 6002.1 6103.3 11542.9 11890.9 11915.2 11941.5 12054.0 11964.4 12208.9 12320.9 12328.9 12333.4 8202.4 8209.7 8232.2 8241.1 8305.1 9615.2 9681.7 9729.4 9743.6 9745.8 7686.1 7800.6 7865.5 7924.1 8060.0 7760.1 7780.8 7880.0 8057.4 8102.0 7521.9 7615.7 7676.7 7705.3 7715.3 4801.4 5327.3 5338.4 5523.8 5615.6 5415.3 5455.6 5490.6 5519.3 5642.9 18:36:20 INFO - PID 25720 | 18:36:20 INFO - PID 25720 | [#4] prototype.html Cycles:180 Average:4816.11 Median:5377.07 stddev:1379.41 (25.7%) stddev-sans-first:1342.16 18:36:20 INFO - PID 25720 | Values: 362.2 368.0 369.5 378.5 386.5 5370.7 5555.3 5563.5 5564.9 5579.6 5345.3 5448.7 5449.1 5470.5 5493.8 4305.5 4308.1 4312.4 4322.7 4326.8 4178.2 4251.2 4266.4 4316.7 4322.5 4215.3 4233.5 4241.6 4247.3 4251.7 4236.8 4246.2 4249.4 4250.7 4253.2 3765.0 3830.8 3834.6 3842.6 3856.2 5350.8 5355.8 5365.0 5383.4 5394.8 5056.1 5058.8 5068.3 5068.7 5082.7 5595.4 5741.4 5747.4 5769.1 5816.9 4314.9 4316.8 4320.2 4328.6 4334.9 5868.4 6059.1 6066.3 6123.9 6170.8 4181.3 4189.4 4199.6 4204.2 4205.1 4272.0 4281.2 4282.1 4286.8 4300.1 4775.3 4862.2 4878.7 4885.1 4906.5 5734.7 5764.0 5781.4 5808.5 5809.7 1563.5 1582.8 1584.4 1589.2 1598.7 1109.9 1113.9 1121.8 1126.4 1142.7 5039.2 5045.5 5049.2 5060.6 5064.4 5943.8 5994.3 6012.6 6022.2 6032.5 4897.5 5003.5 5024.3 5044.3 5047.5 3161.3 3178.3 3179.7 3193.0 3208.3 5369.6 5473.9 5540.5 5553.7 5571.3 6125.5 6125.7 6132.6 6153.5 6174.6 5536.4 5540.5 5548.9 5550.3 5553.1 5930.3 5951.9 5992.7 6009.6 6043.9 5706.6 5860.6 5875.7 5888.8 5909.8 5525.5 5573.6 5576.9 5585.0 5614.4 4021.5 4045.5 4051.3 4057.8 4070.5 5910.0 5910.2 6018.8 6061.0 6073.0 5817.0 5825.3 5825.9 5840.5 5841.6 5702.6 5731.5 5753.1 5803.2 5826.1 5698.7 5738.6 5752.7 5770.2 5798.4 5863.3 5867.4 5876.9 5884.4 5887.3 5544.9 5671.3 5688.0 5700.7 5701.9 18:36:20 INFO - PID 25720 | 18:36:20 INFO - PID 25720 | [#5] yui.html Cycles:180 Average:14652.61 Median:16850.12 stddev:16302.13 (96.7%) stddev-sans-first:16314.34 18:36:20 INFO - PID 25720 | Values: 731.3 749.7 756.3 764.4 768.2 12242.1 12702.9 13271.3 14192.1 14200.4 14778.5 14888.2 15436.2 15490.8 15515.8 858.3 870.3 873.6 874.0 875.0 879.3 881.8 884.0 884.4 887.4 923.4 925.0 928.6 930.8 932.5 910.7 919.3 919.5 921.7 921.8 677.1 678.5 683.5 684.9 685.5 13723.9 13883.4 13901.4 13976.1 14047.9 15414.6 15604.3 15708.2 15895.5 15948.1 11873.8 11918.0 12092.8 12137.1 12189.7 2881.9 2889.9 2907.5 2908.5 2917.4 62881.1 64627.7 65318.0 65411.3 65663.7 12373.3 12610.4 12649.9 12681.5 12724.9 22014.3 22042.7 22386.8 22482.8 22659.0 6069.2 6256.6 6269.1 6325.8 6413.8 3014.2 3062.7 3077.8 3083.8 3102.0 3415.4 3507.9 3511.1 3544.6 3640.5 717.1 718.3 726.0 726.9 726.9 582.5 591.0 603.8 607.7 620.5 9824.6 10519.8 10960.9 10966.5 10984.4 623.9 626.1 630.6 631.4 631.5 4379.6 4546.3 4574.9 4707.8 4740.4 54889.7 55515.4 55791.4 57663.4 61778.4 48344.8 49556.0 50413.7 51176.2 51976.2 46780.3 47764.5 48003.8 48560.0 48701.0 10486.9 11292.5 11459.6 11477.5 11570.1 24797.4 25207.4 25408.2 25517.6 26178.1 30637.5 30648.8 30654.4 30789.0 31507.2 13831.2 13845.6 14122.2 14242.6 14407.1 15403.3 15721.8 16020.4 16342.2 16381.9 13620.3 15082.3 15314.8 15325.7 15734.1 14753.8 14970.7 15084.7 15126.0 15336.0 13857.4 13872.2 13898.2 13999.9 14019.6 10514.2 10830.0 10868.5 10923.5 11099.8 11288.3 11763.2 11862.3 11934.2 12014.4 18:36:20 INFO - PID 25720 | -------- Summary: end -------- 18:36:20 INFO - PID 25720 | 18:36:21 INFO - TEST-INFO | 25720: exit 0 18:36:21 INFO - TEST-OK | dromaeo_css | took 1119002ms 18:36:21 INFO - TEST-START | kraken 18:36:21 INFO - operating with platform_type : linux_ 18:36:21 INFO - Initialising browser for kraken test... 18:36:21 INFO - TEST-INFO | started process 26140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeFXKFf/profile http://localhost:47280/getInfo.html) 18:36:25 INFO - PID 26140 | __metrics Screen width/height:1600/1200 18:36:25 INFO - PID 26140 | colorDepth:24 18:36:25 INFO - PID 26140 | Browser inner width/height: 1024/695 18:36:25 INFO - PID 26140 | __metrics 18:36:27 INFO - TEST-INFO | 26140: exit 0 18:36:27 INFO - Browser initialized. 18:36:27 INFO - Running cycle 1/1 for kraken test... 18:36:27 INFO - TEST-INFO | started process 26312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeFXKFf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:36:39 INFO - PID 26312 | RSS: Main: 155369472 18:36:39 INFO - PID 26312 | 18:36:41 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47280/tests/kraken/driver.html?testName=audio-beat-detection) 18:36:42 INFO - PID 26312 | RSS: Main: 161792000 18:36:42 INFO - PID 26312 | 18:36:45 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47280/tests/kraken/driver.html?testName=audio-dft) 18:36:46 INFO - PID 26312 | RSS: Main: 160382976 18:36:46 INFO - PID 26312 | 18:36:49 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47280/tests/kraken/driver.html?testName=audio-fft) 18:36:49 INFO - PID 26312 | RSS: Main: 156778496 18:36:49 INFO - PID 26312 | 18:36:51 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47280/tests/kraken/driver.html?testName=audio-oscillator) 18:36:52 INFO - PID 26312 | RSS: Main: 158068736 18:36:52 INFO - PID 26312 | 18:36:54 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:36:55 INFO - PID 26312 | RSS: Main: 158175232 18:36:55 INFO - PID 26312 | 18:36:58 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47280/tests/kraken/driver.html?testName=imaging-darkroom) 18:36:58 INFO - PID 26312 | RSS: Main: 162320384 18:36:58 INFO - PID 26312 | 18:37:02 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47280/tests/kraken/driver.html?testName=imaging-desaturate) 18:37:03 INFO - PID 26312 | RSS: Main: 161726464 18:37:03 INFO - PID 26312 | 18:37:05 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47280/tests/kraken/driver.html?testName=json-parse-financial) 18:37:06 INFO - PID 26312 | RSS: Main: 162213888 18:37:06 INFO - PID 26312 | 18:37:08 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:37:08 INFO - PID 26312 | RSS: Main: 162795520 18:37:08 INFO - PID 26312 | 18:37:10 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:37:11 INFO - PID 26312 | RSS: Main: 162476032 18:37:11 INFO - PID 26312 | 18:37:13 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:37:13 INFO - PID 26312 | RSS: Main: 162488320 18:37:13 INFO - PID 26312 | 18:37:16 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:37:17 INFO - PID 26312 | RSS: Main: 162574336 18:37:17 INFO - PID 26312 | 18:37:20 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:37:21 INFO - PID 26312 | RSS: Main: 163201024 18:37:21 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | Cycle 1(1): loaded http://localhost:47280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47280/tests/kraken/driver.html?testName=ai-astar) 18:37:23 INFO - PID 26312 | RSS: Main: 164519936 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | __start_tp_report 18:37:23 INFO - PID 26312 | _x_x_mozilla_page_load 18:37:23 INFO - PID 26312 | _x_x_mozilla_page_load_details 18:37:23 INFO - PID 26312 | |i|pagename|runs| 18:37:23 INFO - PID 26312 | |0;ai-astar;104;112;113;112;112;110;112;111;113;112 18:37:23 INFO - PID 26312 | |1;audio-beat-detection;152;126;121;188;124;122;126;122;146;128 18:37:23 INFO - PID 26312 | |2;audio-dft;163;164;163;164;167;169;169;163;163;164 18:37:23 INFO - PID 26312 | |3;audio-fft;76;75;76;103;77;76;80;76;92;75 18:37:23 INFO - PID 26312 | |4;audio-oscillator;84;83;109;85;84;84;96;84;84;104 18:37:23 INFO - PID 26312 | |5;imaging-gaussian-blur;114;116;114;114;114;114;114;116;114;114 18:37:23 INFO - PID 26312 | |6;imaging-darkroom;151;150;150;152;151;151;149;150;151;150 18:37:23 INFO - PID 26312 | |7;imaging-desaturate;94;95;94;94;95;95;95;94;94;94 18:37:23 INFO - PID 26312 | |8;json-parse-financial;57;54;55;56;56;55;55;56;55;55 18:37:23 INFO - PID 26312 | |9;json-stringify-tinderbox;54;54;55;54;58;55;56;58;55;56 18:37:23 INFO - PID 26312 | |10;stanford-crypto-aes;82;83;82;83;82;83;83;82;82;82 18:37:23 INFO - PID 26312 | |11;stanford-crypto-ccm;135;131;139;142;132;147;154;135;178;151 18:37:23 INFO - PID 26312 | |12;stanford-crypto-pbkdf2;195;192;191;203;191;194;199;189;186;189 18:37:23 INFO - PID 26312 | |13;stanford-crypto-sha256-iterative;74;76;75;77;74;74;73;73;73;72 18:37:23 INFO - PID 26312 | __end_tp_report 18:37:23 INFO - PID 26312 | __start_cc_report 18:37:23 INFO - PID 26312 | _x_x_mozilla_cycle_collect,902 18:37:23 INFO - PID 26312 | __end_cc_report 18:37:23 INFO - PID 26312 | __startTimestamp1494553043348__endTimestamp 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | ------- Summary: start ------- 18:37:23 INFO - PID 26312 | Number of tests: 14 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:2.64 (2.4%) stddev-sans-first:0.93 18:37:23 INFO - PID 26312 | Values: 104.0 112.0 113.0 112.0 112.0 110.0 112.0 111.0 113.0 112.0 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:127.00 stddev:21.30 (16.8%) stddev-sans-first:21.74 18:37:23 INFO - PID 26312 | Values: 152.0 126.0 121.0 188.0 124.0 122.0 126.0 122.0 146.0 128.0 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.00 stddev:2.47 (1.5%) stddev-sans-first:2.52 18:37:23 INFO - PID 26312 | Values: 163.0 164.0 163.0 164.0 167.0 169.0 169.0 163.0 163.0 164.0 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#3] audio-fft Cycles:10 Average:80.60 Median:76.00 stddev:9.38 (12.3%) stddev-sans-first:9.80 18:37:23 INFO - PID 26312 | Values: 76.0 75.0 76.0 103.0 77.0 76.0 80.0 76.0 92.0 75.0 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:84.00 stddev:9.70 (11.5%) stddev-sans-first:10.06 18:37:23 INFO - PID 26312 | Values: 84.0 83.0 109.0 85.0 84.0 84.0 96.0 84.0 84.0 104.0 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:0.84 (0.7%) stddev-sans-first:0.88 18:37:23 INFO - PID 26312 | Values: 114.0 116.0 114.0 114.0 114.0 114.0 114.0 116.0 114.0 114.0 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 18:37:23 INFO - PID 26312 | Values: 151.0 150.0 150.0 152.0 151.0 151.0 149.0 150.0 151.0 150.0 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:37:23 INFO - PID 26312 | Values: 94.0 95.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 94.0 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:0.84 (1.5%) stddev-sans-first:0.67 18:37:23 INFO - PID 26312 | Values: 57.0 54.0 55.0 56.0 56.0 55.0 55.0 56.0 55.0 55.0 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.50 stddev:1.51 (2.7%) stddev-sans-first:1.50 18:37:23 INFO - PID 26312 | Values: 54.0 54.0 55.0 54.0 58.0 55.0 56.0 58.0 55.0 56.0 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 18:37:23 INFO - PID 26312 | Values: 82.0 83.0 82.0 83.0 82.0 83.0 83.0 82.0 82.0 82.0 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:144.50 stddev:14.21 (9.8%) stddev-sans-first:14.66 18:37:23 INFO - PID 26312 | Values: 135.0 131.0 139.0 142.0 132.0 147.0 154.0 135.0 178.0 151.0 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.90 Median:193.00 stddev:5.07 (2.6%) stddev-sans-first:5.32 18:37:23 INFO - PID 26312 | Values: 195.0 192.0 191.0 203.0 191.0 194.0 199.0 189.0 186.0 189.0 18:37:23 INFO - PID 26312 | 18:37:23 INFO - PID 26312 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:74.00 stddev:1.52 (2.1%) stddev-sans-first:1.62 18:37:23 INFO - PID 26312 | Values: 74.0 76.0 75.0 77.0 74.0 74.0 73.0 73.0 73.0 72.0 18:37:23 INFO - PID 26312 | -------- Summary: end -------- 18:37:23 INFO - PID 26312 | 18:37:24 INFO - TEST-INFO | 26312: exit 0 18:37:24 INFO - TEST-OK | kraken | took 63417ms 18:37:24 INFO - SUITE-END | took 1182s 18:37:25 INFO - Completed test suite (00:19:42) 18:37:25 INFO - javascript benchmark 18:37:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6726.924943628228, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2735.1110888961093, 2749.243957911574, 2767.958480622791, 2768.1695491352593, 2783.6937936826957, 5073.264376665391, 5246.134387826009, 5259.395169555502, 5287.180487024508, 5309.619498930277, 5222.399424066233, 5233.188855727369, 5247.396549396821, 5289.180177072551, 5327.946720532794, 4402.380373149698, 4653.488116307203, 4680.5787479126875, 4680.999999999992, 4706.458757242909, 4722.97638511807, 4756.548127927841, 4770.689905156171, 4777.976110119462, 4779.378680771495, 4554.954450455486, 4639.698419602715, 4645.279981602857, 4702.506236845116, 4713.175194340976, 4686.015936653273, 4691.601213896823, 4696.201645720235, 4701.271302948015, 4726.7400292983875, 4609.700369476007, 4634.745089020103, 4665.393498845162, 4667.066586682677, 4688.156131896258, 5102.0, 5113.667611605234, 5159.22611608258, 5214.374275086976, 5221.39953905302, 5484.588655850827, 5488.670679759227, 5502.58730595203, 5503.284573005483, 5516.586256030814, 5515.062439385274, 5517.944820551824, 5520.868222014477, 5526.06056970312, 5541.722913854291, 5094.719790411563, 5126.333576635088, 5145.2024936134585, 5147.382314122329, 5148.0, 5591.552675785927, 5651.237082993744, 5652.152177173457, 5655.0386434306265, 5656.717164141776, 5387.649802762808, 5419.430959749248, 5426.457354264542, 5458.645188062763, 5459.945400546023, 5625.240592520039, 5745.2818397700285, 5760.711964401847, 5765.135229715576, 5767.8558036049435, 5617.129344951457, 5629.746661400247, 5631.662100273997, 5637.0, 5647.068233741386, 5401.216823560561, 5647.632903861236, 5652.265205523256, 5672.8865422691315, 5680.914786278209, 4301.827926882889, 4305.634021108178, 4380.4305440292555, 4397.890052748643, 4409.36064270679, 3830.3105441020325, 3831.252905683365, 3851.78815165163, 3867.0332416895776, 3875.418687196943, 4914.213725803854, 4917.532834380728, 4919.1391506486225, 4924.679895806761, 4948.406191257072, 5588.944110558924, 5661.801836935688, 5673.262475878109, 5681.77272909079, 5761.625494342854, 4827.734474603861, 4836.613070954315, 4846.684965477232, 4847.200211965057, 4855.0, 5022.799088036438, 5030.170021946411, 5130.384353877558, 5145.768440420115, 5153.896922061538, 5308.150695888639, 5356.250124982505, 5363.302770639792, 5365.758540865592, 5370.167624018283, 5703.8003669873015, 5764.308283006066, 5768.53851691872, 5770.798022069207, 5783.913241301299, 5135.589152867837, 5266.07843627356, 5323.760430780547, 5325.307709997675, 5331.733413329395, 5580.609357344947, 5636.323641163087, 5676.886462270814, 5677.0, 5683.488486036276, 5698.487136157766, 5720.713964301852, 5728.369879313355, 5729.2551968245525, 5730.197772311796, 5374.946250537445, 5501.944980550304, 5517.310336207974, 5520.723963801714, 5544.085225937675, 5415.756290966995, 5487.780488780404, 5569.192467092168, 5577.609567330248, 5583.218349431002, 5419.214213939035, 5451.155070964007, 5473.124300111963, 5478.945210547843, 5496.835094947158, 5524.861878453071, 5608.046632072476, 5609.691466969356, 5626.227946575648, 5654.745536450787, 5303.761330740049, 5380.569554435558, 5405.378381486022, 5472.863178420572, 5496.230527726041], "value": 5106.335803422486, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.5787953589238, 722.5484072454715, 743.6281859070463, 1005.6832097889169, 1012.6354512375548, 32901.17747056322, 33814.66185338146, 34105.488417673725, 34138.31723365531, 34196.316073678514, 35249.823750881274, 35528.64471355286, 35728.82135589318, 35734.2853142937, 35772.821135894286, 6734.966325168391, 6910.101686780724, 6993.720251189946, 7047.89428158578, 7059.788206353817, 6996.3003699630135, 7035.296470352975, 7079.85840283194, 7093.645317734118, 7100.005999160122, 7052.753153639624, 7087.503874728771, 7119.074520312352, 7131.500794944356, 7139.785806425815, 7013.789586312419, 7069.681864316092, 7092.078029856111, 7099.077119974396, 7102.751403700846, 6967.93032069683, 6999.790006299819, 7028.19175794785, 7035.0150978863, 7047.43620510358, 32534.837325813456, 32754.836225818955, 32853.83573082143, 32898.17754556155, 32908.341833163206, 3037.255872311298, 3061.586685797411, 3065.4635438798346, 3066.4940284852973, 3070.3091804344067, 24311.756882431127, 24508.26475205747, 24562.631560526606, 24648.383790405205, 24754.0, 3167.889123880653, 3179.586653735023, 3203.19920019995, 3234.304624505719, 3236.2394837213237, 137910.31044844812, 141038.29480852632, 141437.0, 146588.0, 151953.9999999989, 40669.59330406717, 40783.796081019405, 40798.38802417907, 41112.0, 41158.0, 42519.57480425156, 42750.78624606857, 42785.0, 42837.35743963843, 44293.33559996603, 11784.116191285688, 11815.940920295343, 11863.940680296544, 11872.40637968098, 11885.940570297093, 9084.40951338161, 9131.178193962574, 9158.129977652112, 9181.449113053239, 9191.678291259774, 13004.284764337863, 13123.278219698008, 13184.538541151014, 13202.537911173064, 13346.46614135443, 5397.2443857859935, 5447.591430642638, 5492.835214943558, 5494.80768173112, 5503.642263252876, 865.2342676731138, 914.2253261351766, 914.3142643017736, 919.8252332057021, 951.5194826612517, 20476.965522716993, 21296.78703212979, 21687.34937951864, 21750.0, 21961.67057494139, 993.9353941993747, 997.5361456922566, 1003.0270637481631, 1007.3502590829021, 1022.616518805448, 11099.389533575732, 11461.0, 11464.713382165346, 11494.88505114955, 11537.653870383901, 168801.0, 168806.0, 169164.0, 169259.0, 169508.1524592369, 40480.59519404768, 40728.38907416391, 40756.38865417021, 40952.54284742865, 41011.7949410257, 1191.7854786138578, 1235.178606226867, 1244.6266120164096, 1244.925304481734, 1248.17620370555, 19811.0, 20801.687974680088, 21559.05550994016, 21633.0, 21760.673589895847, 30506.389872201988, 33714.0, 34897.30205395928, 34947.30105397827, 35016.64983350134, 158399.0, 159364.0, 159380.0, 159923.0, 160685.0, 30535.847320763252, 30558.388832222787, 30558.694413056473, 30957.380852383278, 31067.533986990664, 36013.45979810358, 36156.63843361638, 37065.258694826494, 37168.81415593013, 37263.44104838484, 27265.0, 27575.31061723473, 27829.30426739267, 28366.0, 29122.56316155217, 27370.726292737614, 27905.44189116247, 28028.0, 28467.0, 29472.705272946994, 30940.845295773375, 31015.844920775253, 31164.597593107912, 31327.53008704917, 31561.52657710182, 25019.374515637253, 26400.867995659897, 26500.0, 27218.455630886874, 27933.301667458476, 20686.275980340615, 22525.324240272817, 22551.661725074464, 22652.093916243164, 22837.65743513882], "value": 14667.258186685896, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.7853516171589, 416.25698128840025, 422.1872894677746, 436.818720231104, 443.3283575383295, 13644.113132646371, 14452.494162704308, 17068.743968840477, 17481.300747970065, 17524.82475175248, 16403.917980410082, 16886.240119194634, 16892.915535422337, 17149.74275385867, 17163.656726865487, 5385.21914322424, 5395.81114660987, 5565.526930210916, 5572.359178694442, 5615.550755939515, 5458.099413596752, 5533.446655334475, 5571.303587051619, 5577.191307260465, 5580.107182850725, 5066.392032956051, 5556.305461817273, 5566.916496252539, 5567.192757050226, 5573.749181286831, 5377.784888604451, 5524.033294173503, 5550.750216240279, 5576.518449290088, 5590.18942253375, 5074.238864170367, 5077.289179514871, 5110.872228194287, 5112.335396398482, 5119.718415487184, 21734.673979890154, 21940.89029554842, 22195.778042219696, 22303.330900073022, 22374.0, 1549.3028137338242, 1596.0343991884858, 1596.4173076826992, 1597.768323593084, 1598.3047374392177, 14553.199574023425, 14642.194679292634, 15008.699826003529, 15056.096634201984, 15064.924675376662, 2036.6334059869218, 2106.262808017197, 2109.377733568601, 2128.6062078515524, 2134.263679030732, 87597.0, 93095.0, 93770.5311473445, 94524.0, 94551.52724236334, 10667.679969600924, 10861.34831910088, 11037.037770799752, 11172.385518796382, 11406.315621062597, 15237.771433428508, 15529.301181446863, 15554.844451555566, 15603.297851596706, 15604.375824967101, 7118.29709424813, 7326.413886889036, 7330.450216233804, 7475.102987641518, 7490.063742032246, 6506.479481641457, 6622.205335359691, 6764.797056088325, 6797.898031529531, 6807.0, 6711.463082953352, 6791.45668346541, 6848.897266541006, 6873.48448866327, 6944.340287672663, 1989.5424052467724, 2012.9798702012793, 2045.7545094588745, 2046.8567200295836, 2146.1522698534304, 824.8515267251832, 854.1117238072335, 878.4070752242211, 884.91150884911, 884.9911500885038, 16454.83545164557, 17101.315947361967, 17363.565910852078, 17722.734158987627, 17728.0, 871.8212766382876, 877.2850127146355, 880.2429910277284, 884.6063501741663, 894.9239314658327, 9062.456252624732, 9395.107464790834, 9685.806283874424, 9704.9029509704, 9784.315097943218, 333739.0, 335207.0, 337717.0, 345144.0, 345557.0, 76246.2375376239, 77201.22798771941, 81612.18387816046, 82030.58984705039, 85378.57310713407, 1066.706655669697, 1103.167108832826, 1114.6823155400673, 1114.9331040137617, 1122.9157813164045, 17341.306347745947, 17722.20250088775, 18176.182071807067, 18317.725234121233, 18585.81414185841, 37624.811875940446, 37760.433593496666, 38029.61970380261, 38066.04834879039, 39871.40192897051, 48852.5114748848, 48920.0, 49051.50948490612, 49094.790734416325, 49195.26207106968, 8248.381371397289, 8267.793305167419, 8351.41540092212, 8430.072692003998, 8594.613242403982, 11950.760984780429, 12167.0, 12225.388730563258, 12531.74936501283, 13035.804462932874, 10086.445245511568, 10471.842922356323, 10496.317739346918, 11081.501332439899, 11301.886981130083, 10390.688279351632, 10494.422806745702, 10549.367037977747, 10554.313969591953, 10650.73373165677, 11274.492647830702, 11336.433178341214, 11378.886211138113, 11498.310101393943, 11726.824097638371, 8285.171482851667, 8559.443636163629, 8656.870146947675, 8692.826143476968, 8706.347023973354, 10610.363378197333, 10897.0, 10937.671869843918, 11141.777164456504, 11266.83099753488], "value": 8812.364253325668, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.4946021591363, 1306.1053178572672, 1311.9212847229167, 1312.7440149170905, 1319.5183757928353, 9734.0, 10164.339317944337, 10176.08415242628, 10455.686329410111, 10788.622398216065, 10570.101541368973, 10728.78542429151, 10758.139348852093, 10762.192835537346, 10763.192760542972, 2212.6902233687297, 2251.279590531031, 2259.4690247791837, 2267.9886600566974, 2273.3634582316977, 2190.518086021073, 2255.2670382125793, 2262.8416010879246, 2265.2977576951116, 2267.240474441056, 2225.4547635829163, 2225.4547635829244, 2277.7038984931937, 2279.908803647852, 2286.085565773687, 2187.58435897179, 2203.636399993999, 2236.0943817753837, 2245.854019488728, 2247.381969958258, 1826.1690930626532, 1902.3627084926427, 2198.362474882282, 2210.701555290031, 2214.3135627955226, 10253.025962533547, 10372.273940824145, 10377.11794497461, 10380.948095259475, 10412.739681508023, 5667.518260947824, 5806.970965145189, 5878.735456904449, 5882.029465138247, 5914.704264786744, 3306.7354611631254, 3457.9308413831836, 3472.5485686860548, 3525.4006818840858, 3555.3600351936643, 1067.4555976451988, 1090.7327704712395, 1123.309164863603, 1147.5868687272575, 1157.1899670230873, 14998.100113993087, 15118.546443606709, 15149.772753408597, 15295.770563441558, 15321.540353789293, 4487.842925497592, 4734.26618874075, 4852.272159176152, 4890.682105663121, 4915.26271059344, 10895.128389728803, 10900.563977440814, 10908.34549927007, 10909.18181136418, 10954.726131846768, 5511.972440137773, 5518.33779946401, 5522.0336441122645, 5564.109742441271, 5568.136938774496, 4916.532929371704, 5129.923051154161, 5155.845324640267, 5176.430592634807, 5186.040582492251, 3863.2466668999277, 3966.8413263469715, 3977.264206121819, 4018.8593399230886, 4077.041895154636, 1145.570411095839, 1157.4907040901976, 1162.604714397109, 1167.8948894599528, 1173.3370645585217, 669.6885948034187, 686.9210040845267, 688.1398252184769, 707.4411215139982, 709.0888208651858, 5028.949710502849, 5125.64120511568, 5152.536271735562, 5289.841304760864, 5297.8145764898045, 523.9476052394806, 534.7593582887716, 537.196890648483, 537.2076187623303, 537.7577795292885, 3235.385276797401, 3255.9837200813845, 3275.606927168755, 3278.2951665392056, 3366.32673465303, 12781.0, 12864.421101050288, 13308.73382532344, 13415.0, 13519.391627376595, 13238.073334866467, 13308.334583270798, 13313.201207927556, 13315.40080696371, 13335.466581336832, 7220.783376498714, 7519.360854327334, 7526.661300241502, 7546.962265188639, 7556.4710470266555, 5887.646741195542, 5902.2327097477055, 5909.52723782105, 6002.129691194665, 6103.328633850184, 11542.94228528852, 11890.940545297219, 11915.2255103418, 11941.462634181657, 12054.0, 11964.401779910795, 12208.877911220774, 12320.876791231973, 12328.876711233132, 12333.383330833602, 8202.384821138558, 8209.71266005687, 8232.217939295757, 8241.093479717107, 8305.086440491421, 9615.23078153732, 9681.66114186, 9729.416235025921, 9743.56153973087, 9745.756356091155, 7686.116096648733, 7800.6099695016155, 7865.528068315919, 7924.1283458820635, 8060.03279606451, 7760.14638389788, 7780.805479863048, 7880.0, 8057.435979481615, 8102.0, 7521.8871716923195, 7615.65729542183, 7676.692932282869, 7705.267999540035, 7715.344195743424, 4801.375821143229, 5327.286771484905, 5338.439463856239, 5523.7790488380015, 5615.578831587565, 5415.323084614423, 5455.61810673265, 5490.615656903979, 5519.2824932758485, 5642.887142257214], "value": 4690.455122170492, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.1814698780756, 367.9981600091999, 369.5214696967426, 378.5041595509882, 386.45123924027877, 5370.7046112463795, 5555.33339998001, 5563.471470210334, 5564.888702225953, 5579.553635709143, 5345.33183352081, 5448.727563621813, 5449.100898351777, 5470.452954704538, 5493.752781124849, 4305.504866940295, 4308.138372325548, 4312.374705667677, 4322.697411181219, 4326.783660816946, 4178.227027999815, 4251.192273468031, 4266.424032755584, 4316.704988503452, 4322.459692538433, 4215.283401821683, 4233.470816147981, 4241.639460645833, 4247.25673007224, 4251.723637963538, 4236.809343579531, 4246.171996460692, 4249.366791393376, 4250.702450828443, 4253.1706317268145, 3765.021094515418, 3830.8276127574327, 3834.616538346171, 3842.5965273646425, 3856.151646637735, 5350.8127215547265, 5355.7857685692525, 5364.973175134139, 5383.43473935235, 5394.838154855322, 5056.140456122468, 5058.797648094109, 5068.315777370081, 5068.69587824728, 5082.720450375228, 5595.38450770415, 5741.425857414267, 5747.367789543188, 5769.134629805562, 5816.912746308809, 4314.935275970863, 4316.848910288125, 4320.1575692739925, 4328.588784065509, 4334.934975975363, 5868.383819698913, 6059.121427393047, 6066.272047354346, 6123.928312545287, 6170.81487555374, 4181.330987042059, 4189.350650649154, 4199.622034016953, 4204.180184863983, 4205.095904380573, 4271.974726065784, 4281.207976524353, 4282.143571285756, 4286.764227967492, 4300.0969796343115, 4775.307580400892, 4862.17343051682, 4878.707277563358, 4885.120678277873, 4906.460289368167, 5734.7132643368495, 5763.991301522301, 5781.386633354154, 5808.5062769665055, 5809.651420914759, 1563.4606060908968, 1582.8179759327825, 1584.382090984517, 1589.1577463944127, 1598.6642805010845, 1109.8501702270253, 1113.8551988241477, 1121.8149005414016, 1126.4367816091954, 1142.6572028391615, 5039.244113383022, 5045.495450454925, 5049.192129259301, 5060.645754797202, 5064.392272927273, 5943.762249510058, 5994.340622531518, 6012.617098067381, 6022.2171117754415, 6032.547558933097, 4897.461279259279, 5003.549680528697, 5024.271480635288, 5044.2937988681615, 5047.470015648304, 3161.2571045804216, 3178.2848859007, 3179.7440011195913, 3192.9680703193135, 3208.262099717078, 5369.624126311199, 5473.9452605474235, 5540.501354878081, 5553.666779993213, 5571.275734154615, 6125.540584456184, 6125.663088530174, 6132.5707200495535, 6153.538484613582, 6174.598651087755, 5536.363318218457, 5540.529055030287, 5548.889022219533, 5550.250716153349, 5553.111502159635, 5930.258717660293, 5951.940480595139, 5992.67040312787, 6009.609375390585, 6043.909341359971, 5706.629069110494, 5860.648361098348, 5875.706214689334, 5888.764449421975, 5909.793157239476, 5525.502704756591, 5573.6098473106495, 5576.944230557642, 5585.0, 5614.438556144353, 4021.4973128358956, 4045.534763502235, 4051.2505186540584, 4057.797110144422, 4070.4504891839224, 5909.970450147722, 5910.202122713378, 6018.8194354169445, 6061.0, 6073.0, 5816.970915145397, 5825.330087039875, 5825.854353641193, 5840.532757379485, 5841.561882858888, 5702.600817942704, 5731.455511726379, 5753.079507278815, 5803.245578074823, 5826.067829147316, 5698.686572238566, 5738.598298119258, 5752.654840709571, 5770.192173095686, 5798.362180160263, 5863.296404431496, 5867.413258674099, 5876.882462350814, 5884.382139875423, 5887.322957859901, 5544.861378465571, 5671.347795003628, 5687.971560142173, 5700.657960522382, 5701.945140149086], "value": 4398.549611528969, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.2687312687312, 749.718855429214, 756.3117563017655, 764.4304992780379, 768.2202564397138, 12242.143049986504, 12702.872971270284, 13271.33643317834, 14192.07751496152, 14200.431982720691, 14778.482753103644, 14888.181150036744, 15436.228188590581, 15490.845091549081, 15515.767263491029, 858.3347905373323, 870.316801310971, 873.5632183908046, 873.978150546235, 875.0374587953232, 879.3053487744673, 881.7531091294447, 883.9734807955772, 884.3941899798658, 887.414306557672, 923.376720713519, 925.0148591749798, 928.5635751196927, 930.8231436027168, 932.4778124250407, 910.7131253655077, 919.3013309884469, 919.517253441945, 921.7234829551142, 921.7511271956567, 677.0926957876469, 678.4572342126279, 683.4976292425114, 684.8596037812237, 685.5098604497808, 13723.862761372358, 13883.4446622135, 13901.374438150307, 13976.091554049057, 14047.859521404758, 15414.614634634112, 15604.29780659873, 15708.214589270605, 15895.52313430599, 15948.122853243067, 11873.762524749543, 11918.033524468452, 12092.758144837055, 12137.089718271165, 12189.69525761863, 2881.942361152765, 2889.8699558519916, 2907.4911890419094, 2908.5200941844782, 2917.3873486567845, 62881.05678414782, 64627.67686161586, 65318.0, 65411.345886541, 65663.67168164176, 12373.257604543756, 12610.432530536147, 12649.87350126487, 12681.492740290285, 12724.872751272369, 22014.33956981261, 22042.669359959615, 22386.776132238796, 22482.775172248068, 22659.0, 6069.211002569726, 6256.624602523863, 6269.059641053878, 6325.778597749057, 6413.839654008594, 3014.216303761038, 3062.693730626964, 3077.8307193104592, 3083.768717346208, 3101.98449007758, 3415.419378705626, 3507.9123021924656, 3511.0695665648623, 3544.61009288978, 3640.453931910182, 717.103620474407, 718.321186478783, 725.9528130671489, 726.8655298769745, 726.920038795732, 582.4612233683825, 590.9881802364015, 603.8309273403454, 607.7386723708847, 620.4942971478231, 9824.557894894748, 10519.84220236697, 10960.945195273973, 10966.451677416097, 10984.395858227874, 623.8752249550108, 626.1421852062613, 630.6090224061112, 631.3938618925882, 631.4664108828033, 4379.605835474759, 4546.318052292117, 4574.885627859264, 4707.764611769398, 4740.407449068866, 54889.72555137279, 55515.44484555103, 55791.44208557944, 57663.42336576664, 61778.382216178165, 48344.7582762091, 49556.0, 50413.747931260106, 51176.208832690674, 51976.22035669468, 46780.298295525594, 47764.5223547767, 48003.75998119987, 48560.0, 48701.02597948021, 10486.947565262124, 11292.491837867152, 11459.598914037968, 11477.48351324209, 11570.132240081859, 24797.380065498506, 25207.36981575475, 25408.237752867444, 25517.61723574111, 26178.08376706806, 30637.540436893018, 30648.846755766077, 30654.386912262074, 30789.0, 31507.21231969219, 13831.170129792245, 13845.584632461043, 14122.152670839783, 14242.643933901736, 14407.06354086981, 15403.306851191948, 15721.842781572037, 16020.439284624983, 16342.182890855647, 16381.870356853533, 13620.250886201355, 15082.321295541507, 15314.770278445609, 15325.693486130438, 15734.134622595868, 14753.778693319824, 14970.700585988438, 15084.698306034037, 15126.0, 15336.0, 13857.445702172203, 13872.167669939836, 13898.23559704226, 13999.930000349934, 14019.579412617637, 10514.158867290751, 10830.0, 10868.456577171268, 10923.508442120283, 11099.833502497631, 11288.322700637988, 11763.176577639482, 11862.347570883685, 11934.22427542207, 12014.399280036137], "value": 6804.442402217978, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 112.0, 112.0, 110.0, 112.0, 111.0, 113.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 121.0, 188.0, 124.0, 122.0, 126.0, 122.0, 146.0, 128.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 164.0, 167.0, 169.0, 169.0, 163.0, 163.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 103.0, 77.0, 76.0, 80.0, 76.0, 92.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 109.0, 85.0, 84.0, 84.0, 96.0, 84.0, 84.0, 104.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 114.0, 114.0, 114.0, 114.0, 116.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 152.0, 151.0, 151.0, 149.0, 150.0, 151.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 55.0, 56.0, 56.0, 55.0, 55.0, 56.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 58.0, 55.0, 56.0, 58.0, 55.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 83.0, 82.0, 83.0, 83.0, 82.0, 82.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 131.0, 139.0, 142.0, 132.0, 147.0, 154.0, 135.0, 178.0, 151.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 192.0, 191.0, 203.0, 191.0, 194.0, 199.0, 189.0, 186.0, 189.0], "value": 192.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 77.0, 74.0, 74.0, 73.0, 73.0, 73.0, 72.0], "value": 74.1, "unit": "score"}]}]} 18:37:25 INFO - Return code: 0 18:37:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:37:25 INFO - # TBPL SUCCESS # 18:37:25 INFO - Running post-action listener: _resource_record_post_action 18:37:25 INFO - [mozharness: 2017-05-12 01:37:25.175498Z] Finished run-tests step (success) 18:37:25 INFO - Running post-run listener: _resource_record_post_run 18:37:25 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 375758848; Read time: 0; Write time: 230328 18:37:25 INFO - TinderboxPrint: CPU usage
13.3% 18:37:25 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:37:25 INFO - TinderboxPrint: I/O write bytes / time
375,758,848 / 230,328 18:37:25 INFO - TinderboxPrint: CPU idle
8,298.4 (86.7%) 18:37:25 INFO - TinderboxPrint: CPU user
1,213.3 (12.7%) 18:37:25 INFO - TinderboxPrint: Swap in / out
0 / 0 18:37:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 112795648; Read time: 0; Write time: 97036 18:37:25 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 262963200; Read time: 0; Write time: 133292 18:37:25 INFO - Running post-run listener: _upload_blobber_files 18:37:25 INFO - Blob upload gear active. 18:37:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:37:25 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 18:37:25 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'] 18:37:25 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 18:37:26 INFO - (blobuploader) - INFO - Open directory for files ... 18:37:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:37:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:37:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:37:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:27 INFO - (blobuploader) - INFO - Done attempting. 18:37:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:37:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:37:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:28 INFO - (blobuploader) - INFO - Done attempting. 18:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:37:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:37:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:37:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:28 INFO - (blobuploader) - INFO - Done attempting. 18:37:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:37:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:37:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:37:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:37:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:37:32 INFO - (blobuploader) - INFO - Done attempting. 18:37:32 INFO - (blobuploader) - INFO - Iteration through files over. 18:37:32 INFO - Return code: 0 18:37:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:37:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:37:32 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b2af3a44437f1ee928e1777a27507f2dd6ede5c63650d4818054dc2bc308b4b5c0b347a7597daab6fb791e9d148fe3bcb02bc8ae5fea56c2c22a6ba6d76ff1f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76b4eaab6bf405aa9aec36797ac5873855d6fe532133ec9f0331aa549b46de960a3a8928da6ba4ade4d79fad9515a19fbc4d3513bf3ea5c564a5cf2d57156ea7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8b314816f9be9c04510d7f79f0ff5d8f687a43478420037c7cdbbbf60273a990c6f576b9c08e8c0736fbc7ec05fd52fb2be3777747a02562970108c8b3386dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39e633211c76ea4fe02c87aab3f550a03935d7395a42f40d8445fbff48d9836e210455c492f0757431b83be311184f5f687f49c382a82f9aafad029e009920a0"} 18:37:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:37:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:37:32 INFO - Contents: 18:37:32 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b2af3a44437f1ee928e1777a27507f2dd6ede5c63650d4818054dc2bc308b4b5c0b347a7597daab6fb791e9d148fe3bcb02bc8ae5fea56c2c22a6ba6d76ff1f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76b4eaab6bf405aa9aec36797ac5873855d6fe532133ec9f0331aa549b46de960a3a8928da6ba4ade4d79fad9515a19fbc4d3513bf3ea5c564a5cf2d57156ea7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8b314816f9be9c04510d7f79f0ff5d8f687a43478420037c7cdbbbf60273a990c6f576b9c08e8c0736fbc7ec05fd52fb2be3777747a02562970108c8b3386dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39e633211c76ea4fe02c87aab3f550a03935d7395a42f40d8445fbff48d9836e210455c492f0757431b83be311184f5f687f49c382a82f9aafad029e009920a0"} 18:37:32 INFO - Running post-run listener: copy_logs_to_upload_dir 18:37:32 INFO - Copying logs to upload dir... 18:37:32 INFO - mkdir: /builds/slave/test/build/upload/logs 18:37:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.416209 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-11 18:37:32.248878) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:32.252818) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436 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/5b2af3a44437f1ee928e1777a27507f2dd6ede5c63650d4818054dc2bc308b4b5c0b347a7597daab6fb791e9d148fe3bcb02bc8ae5fea56c2c22a6ba6d76ff1f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76b4eaab6bf405aa9aec36797ac5873855d6fe532133ec9f0331aa549b46de960a3a8928da6ba4ade4d79fad9515a19fbc4d3513bf3ea5c564a5cf2d57156ea7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8b314816f9be9c04510d7f79f0ff5d8f687a43478420037c7cdbbbf60273a990c6f576b9c08e8c0736fbc7ec05fd52fb2be3777747a02562970108c8b3386dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39e633211c76ea4fe02c87aab3f550a03935d7395a42f40d8445fbff48d9836e210455c492f0757431b83be311184f5f687f49c382a82f9aafad029e009920a0"} build_url:https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/dGUIyOthRJK_MESGw0MYbQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b2af3a44437f1ee928e1777a27507f2dd6ede5c63650d4818054dc2bc308b4b5c0b347a7597daab6fb791e9d148fe3bcb02bc8ae5fea56c2c22a6ba6d76ff1f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/76b4eaab6bf405aa9aec36797ac5873855d6fe532133ec9f0331aa549b46de960a3a8928da6ba4ade4d79fad9515a19fbc4d3513bf3ea5c564a5cf2d57156ea7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a8b314816f9be9c04510d7f79f0ff5d8f687a43478420037c7cdbbbf60273a990c6f576b9c08e8c0736fbc7ec05fd52fb2be3777747a02562970108c8b3386dc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/39e633211c76ea4fe02c87aab3f550a03935d7395a42f40d8445fbff48d9836e210455c492f0757431b83be311184f5f687f49c382a82f9aafad029e009920a0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:32.277543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:32.277861) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1494551798.419785-1414427436 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:32.361348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 18:37:32.361678) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 18:37:32.361971) ========= ========= Total master_lag: 0.16 =========