builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-086 starttime: 1494553061.36 results: success (0) revision: 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:41.357363) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:41.357854) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:41.358166) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:41.373533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:41.373998) ========= 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=438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-11 18:37:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-05-11 18:37:41 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140350 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:41.528707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:41.529026) ========= 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=438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019246 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:41.578433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:41.578809) ========= 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=438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-11 18:37:41,755 truncating revision to first 12 chars 2017-05-11 18:37:41,755 Setting DEBUG logging. 2017-05-11 18:37:41,755 attempt 1/10 2017-05-11 18:37:41,755 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:37:42,039 unpacking tar archive at: mozilla-central-2a8e0c4be57d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.605449 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:42.197670) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:42.197980) ========= script_repo_revision: 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:42.198412) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:42.198686) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 18:37:42.206901) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-05-11 18:37:42.207230) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:37:42 INFO - MultiFileLogger online at 20170511 18:37:42 in /builds/slave/test 18:37:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:37:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:37:42 INFO - {'append_to_log': False, 18:37:42 INFO - 'base_work_dir': '/builds/slave/test', 18:37:42 INFO - 'blob_upload_branch': 'Firefox', 18:37:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:37:42 INFO - 'branch': 'Firefox', 18:37:42 INFO - 'buildbot_json_path': 'buildprops.json', 18:37:42 INFO - 'config_files': ('talos/linux_config.py',), 18:37:42 INFO - 'default_actions': ('clobber', 18:37:42 INFO - 'read-buildbot-config', 18:37:42 INFO - 'download-and-extract', 18:37:42 INFO - 'populate-webroot', 18:37:42 INFO - 'create-virtualenv', 18:37:42 INFO - 'install', 18:37:42 INFO - 'run-tests'), 18:37:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:37:42 INFO - 'download_minidump_stackwalk': True, 18:37:42 INFO - 'download_symbols': 'ondemand', 18:37:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:37:42 INFO - 'tooltool.py': '/tools/tooltool.py', 18:37:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:37:42 INFO - '/tools/misc-python/virtualenv.py')}, 18:37:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:37:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:37:42 INFO - 'gecko_profile': False, 18:37:42 INFO - 'gecko_profile_interval': 0, 18:37:42 INFO - 'installer_path': 'installer.exe', 18:37:42 INFO - 'log_level': 'info', 18:37:42 INFO - 'log_name': 'talos', 18:37:42 INFO - 'log_to_console': True, 18:37:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:37:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:37:42 INFO - 'opt_config_files': (), 18:37:42 INFO - 'pip_index': False, 18:37:42 INFO - 'suite': 'dromaeojs', 18:37:42 INFO - 'system_bits': '32', 18:37:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:37:42 INFO - 'title': 'talos-linux64-ix-086', 18:37:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:37:42 INFO - 'use_talos_json': True, 18:37:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:37:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:37:42 INFO - 'work_dir': 'build'} 18:37:42 INFO - [mozharness: 2017-05-12 01:37:42.479787Z] Running clobber step. 18:37:42 INFO - Running pre-action listener: _resource_record_pre_action 18:37:42 INFO - Running main action method: clobber 18:37:42 INFO - rmtree: /builds/slave/test/build 18:37:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:37:43 INFO - Running post-action listener: _resource_record_post_action 18:37:43 INFO - [mozharness: 2017-05-12 01:37:43.490818Z] Finished clobber step (success) 18:37:43 INFO - [mozharness: 2017-05-12 01:37:43.490919Z] Running read-buildbot-config step. 18:37:43 INFO - Running pre-action listener: _resource_record_pre_action 18:37:43 INFO - Running main action method: read_buildbot_config 18:37:43 INFO - Using buildbot properties: 18:37:43 INFO - { 18:37:43 INFO - "project": "", 18:37:43 INFO - "product": "firefox", 18:37:43 INFO - "who": "kwierso@gmail.com", 18:37:43 INFO - "installer_path": "public/build/target.tar.bz2", 18:37:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:37:43 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:37:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 18:37:43 INFO - "stage_platform": "linux64-pgo", 18:37:43 INFO - "basedir": "/builds/slave/test", 18:37:43 INFO - "buildnumber": 179, 18:37:43 INFO - "platform": "ubuntu64_hw", 18:37:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:37:43 INFO - "slavebuilddir": "test", 18:37:43 INFO - "taskId": "Q-SK3zl9Q5Kh3jEgg8Mcbg", 18:37:43 INFO - "branch": "mozilla-central", 18:37:43 INFO - "script_repo_revision": "production", 18:37:43 INFO - "revision": "2a8e0c4be57d244bf59543750d047b2ab7c8bbdc", 18:37:43 INFO - "slavename": "talos-linux64-ix-086", 18:37:43 INFO - "repo_path": "mozilla-central" 18:37:43 INFO - } 18:37:43 INFO - Finding installer, test and symbols from parent task. 18:37:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q-SK3zl9Q5Kh3jEgg8Mcbg'}, attempt #1 18:37:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q-SK3zl9Q5Kh3jEgg8Mcbg'}, attempt #1 18:37:44 INFO - Task dependencies: ciflkEnOT-KA2bdcDyiU1w 18:37:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w'}, attempt #1 18:37:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2 18:37:44 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/test_packages.json 18:37:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.crashreporter-symbols.zip 18:37:44 INFO - Running post-action listener: _resource_record_post_action 18:37:44 INFO - [mozharness: 2017-05-12 01:37:44.849147Z] Finished read-buildbot-config step (success) 18:37:44 INFO - [mozharness: 2017-05-12 01:37:44.849365Z] Running download-and-extract step. 18:37:44 INFO - Running pre-action listener: _resource_record_pre_action 18:37:44 INFO - Running main action method: download_and_extract 18:37:44 INFO - mkdir: /builds/slave/test/build/tests 18:37:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:44 INFO - trying https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.test_packages.json 18:37:44 INFO - Downloading https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:37:45 INFO - Downloaded 986 bytes. 18:37:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:37:45 INFO - Using the following test package requirements: 18:37:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:37:45 INFO - u'common': [u'target.common.tests.zip'], 18:37:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:37:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:37:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:37:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:37:45 INFO - u'mozbase': [u'target.common.tests.zip'], 18:37:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:37:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:37:45 INFO - u'web-platform': [u'target.common.tests.zip', 18:37:45 INFO - u'target.web-platform.tests.zip'], 18:37:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:37:45 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:37:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.common.tests.zip 18:37:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:37:45 INFO - Fetch https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.common.tests.zip into memory 18:37:46 INFO - Content-Length response header: 60742174 18:37:46 INFO - Bytes received: 60742174 18:37:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:37:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.common.tests.zip 18:37:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:37:56 INFO - Fetch https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.common.tests.zip into memory 18:37:57 INFO - Content-Length response header: 60742174 18:37:57 INFO - Bytes received: 60742174 18:38:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.talos.tests.zip 18:38:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:38:08 INFO - Fetch https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.talos.tests.zip into memory 18:38:09 INFO - Content-Length response header: 14409411 18:38:09 INFO - Bytes received: 14409411 18:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:09 INFO - trying https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2 18:38:09 INFO - Downloading https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:38:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:38:10 INFO - Downloaded 68832966 bytes. 18:38:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2 18:38:10 INFO - mkdir: /builds/slave/test/properties 18:38:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:38:10 INFO - Writing to file /builds/slave/test/properties/build_url 18:38:10 INFO - Contents: 18:38:10 INFO - build_url:https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2 18:38:10 INFO - Running post-action listener: _resource_record_post_action 18:38:10 INFO - Running post-action listener: set_extra_try_arguments 18:38:10 INFO - [mozharness: 2017-05-12 01:38:10.552352Z] Finished download-and-extract step (success) 18:38:10 INFO - [mozharness: 2017-05-12 01:38:10.552450Z] Running populate-webroot step. 18:38:10 INFO - Running pre-action listener: _resource_record_pre_action 18:38:10 INFO - Running main action method: populate_webroot 18:38:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:38:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:38:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:38:10 INFO - '--tppagecycles', 18:38:10 INFO - '7'], 18:38:10 INFO - 'tests': ['tsvgm']}}, 18:38:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:38:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:38:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:38:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:38:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:38:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:38:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:38:10 INFO - 'talos_options': ['--disable-e10s'], 18:38:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:38:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:38:10 INFO - 'talos_options': ['--disable-e10s'], 18:38:10 INFO - 'tests': ['damp', 'tps']}, 18:38:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:38:10 INFO - 'tests': ['damp', 'tps']}, 18:38:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:38:10 INFO - 'tests': ['dromaeo_dom']}, 18:38:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:38:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:38:10 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:38:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:38:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:38:10 INFO - 'tests': ['a11yr', 18:38:10 INFO - 'ts_paint', 18:38:10 INFO - 'tpaint', 18:38:10 INFO - 'sessionrestore', 18:38:10 INFO - 'sessionrestore_no_auto_restore', 18:38:10 INFO - 'tabpaint']}, 18:38:10 INFO - 'other-e10s': {'tests': ['a11yr', 18:38:10 INFO - 'ts_paint', 18:38:10 INFO - 'tpaint', 18:38:10 INFO - 'sessionrestore', 18:38:10 INFO - 'sessionrestore_no_auto_restore', 18:38:10 INFO - 'tabpaint']}, 18:38:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:38:10 INFO - 'ts_paint', 18:38:10 INFO - 'tpaint', 18:38:10 INFO - 'sessionrestore', 18:38:10 INFO - 'sessionrestore_no_auto_restore', 18:38:10 INFO - 'tabpaint']}, 18:38:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:38:10 INFO - 'ts_paint', 18:38:10 INFO - 'tpaint', 18:38:10 INFO - 'sessionrestore', 18:38:10 INFO - 'sessionrestore_no_auto_restore', 18:38:10 INFO - 'tabpaint']}, 18:38:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:38:10 INFO - 'tests': ['a11yr', 18:38:10 INFO - 'ts_paint', 18:38:10 INFO - 'tpaint', 18:38:10 INFO - 'sessionrestore', 18:38:10 INFO - 'sessionrestore_no_auto_restore', 18:38:10 INFO - 'tabpaint']}, 18:38:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:38:10 INFO - 'tests': ['a11yr', 18:38:10 INFO - 'ts_paint', 18:38:10 INFO - 'tpaint', 18:38:10 INFO - 'sessionrestore', 18:38:10 INFO - 'sessionrestore_no_auto_restore', 18:38:10 INFO - 'tabpaint']}, 18:38:10 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:38:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:38:10 INFO - 'bloom_basic_ref']}, 18:38:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:38:10 INFO - 'tests': ['tsvgx', 18:38:10 INFO - 'tsvgr_opacity', 18:38:10 INFO - 'tart', 18:38:10 INFO - 'tscrollx', 18:38:10 INFO - 'cart', 18:38:10 INFO - 'tsvg_static']}, 18:38:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:38:10 INFO - 'tsvgr_opacity', 18:38:10 INFO - 'tart', 18:38:10 INFO - 'tscrollx', 18:38:10 INFO - 'cart', 18:38:10 INFO - 'tsvg_static']}, 18:38:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:38:10 INFO - 'talos_options': ['--disable-e10s'], 18:38:10 INFO - 'tests': ['tp5o']}, 18:38:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:38:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:38:10 INFO - 'talos_options': ['--disable-e10s', 18:38:10 INFO - '--xperf_path', 18:38:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:10 INFO - 'tests': ['tp5n']}, 18:38:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:38:10 INFO - 'talos_options': ['--xperf_path', 18:38:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:10 INFO - 'tests': ['tp5n']}}, 18:38:10 INFO - 'talos.zip': {'path': '', 18:38:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:38:10 INFO - Running post-action listener: _resource_record_post_action 18:38:10 INFO - [mozharness: 2017-05-12 01:38:10.566139Z] Finished populate-webroot step (success) 18:38:10 INFO - [mozharness: 2017-05-12 01:38:10.566228Z] Running create-virtualenv step. 18:38:10 INFO - Running pre-action listener: _resource_record_pre_action 18:38:10 INFO - Running main action method: create_virtualenv 18:38:10 INFO - Creating virtualenv /builds/slave/test/build/venv 18:38:10 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:38:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:38:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:38:10 INFO - Using real prefix '/usr' 18:38:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:38:11 INFO - Installing distribute.............................................................................................................................................................................................done. 18:38:13 INFO - Installing pip.................done. 18:38:13 INFO - Return code: 0 18:38:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:38:13 INFO - Reading from file tmpfile_stdout 18:38:13 INFO - Output received: 18:38:13 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:38:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:38: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:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38: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:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4aa30>, '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 0xd4b7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4bca0>, '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': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', '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:38: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', 'pip>=1.5'] in /builds/slave/test/build 18:38: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 pip>=1.5 18:38:13 INFO - Using env: {'DISPLAY': ':0', 18:38:13 INFO - 'HOME': '/home/cltbld', 18:38:13 INFO - 'LANG': 'en_US.UTF-8', 18:38:13 INFO - 'LANGUAGE': 'en_US:en', 18:38:13 INFO - 'LOGNAME': 'cltbld', 18:38:13 INFO - 'MAIL': '/var/mail/cltbld', 18:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:13 INFO - 'MOZ_NO_REMOTE': '1', 18:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:13 INFO - 'NO_EM_RESTART': '1', 18:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:13 INFO - 'PWD': '/builds/slave/test', 18:38:13 INFO - 'SHELL': '/bin/bash', 18:38:13 INFO - 'SHLVL': '1', 18:38:13 INFO - 'TERM': 'linux', 18:38:13 INFO - 'TMOUT': '86400', 18:38:13 INFO - 'USER': 'cltbld', 18:38:13 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', 18:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:13 INFO - '_': '/tools/buildbot/bin/python'} 18:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:13 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:38:13 INFO - Cleaning up... 18:38:13 INFO - Return code: 0 18:38:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:38: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:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38: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:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38: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', '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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4aa30>, '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 0xd4b7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4bca0>, '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': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', '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:38: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:38: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 psutil>=3.1.1 18:38:13 INFO - Using env: {'DISPLAY': ':0', 18:38:13 INFO - 'HOME': '/home/cltbld', 18:38:13 INFO - 'LANG': 'en_US.UTF-8', 18:38:13 INFO - 'LANGUAGE': 'en_US:en', 18:38:13 INFO - 'LOGNAME': 'cltbld', 18:38:13 INFO - 'MAIL': '/var/mail/cltbld', 18:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:13 INFO - 'MOZ_NO_REMOTE': '1', 18:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:13 INFO - 'NO_EM_RESTART': '1', 18:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:13 INFO - 'PWD': '/builds/slave/test', 18:38:13 INFO - 'SHELL': '/bin/bash', 18:38:13 INFO - 'SHLVL': '1', 18:38:13 INFO - 'TERM': 'linux', 18:38:13 INFO - 'TMOUT': '86400', 18:38:13 INFO - 'USER': 'cltbld', 18:38:13 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', 18:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:13 INFO - '_': '/tools/buildbot/bin/python'} 18:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:13 INFO - Downloading/unpacking psutil>=3.1.1 18:38: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:38: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:38: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:38: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:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:38:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:14 INFO - Installing collected packages: psutil 18:38:14 INFO - Running setup.py install for psutil 18:38:15 INFO - building 'psutil._psutil_linux' extension 18:38:15 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:38:15 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:38:15 INFO - building 'psutil._psutil_posix' extension 18:38:15 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:38:15 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:38:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:15 INFO - Successfully installed psutil 18:38:15 INFO - Cleaning up... 18:38:15 INFO - Return code: 0 18:38:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:38:15 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:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:15 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:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:15 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4aa30>, '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 0xd4b7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4bca0>, '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': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', '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:38:15 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:38:15 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:38:15 INFO - Using env: {'DISPLAY': ':0', 18:38:15 INFO - 'HOME': '/home/cltbld', 18:38:15 INFO - 'LANG': 'en_US.UTF-8', 18:38:15 INFO - 'LANGUAGE': 'en_US:en', 18:38:15 INFO - 'LOGNAME': 'cltbld', 18:38:15 INFO - 'MAIL': '/var/mail/cltbld', 18:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:15 INFO - 'MOZ_NO_REMOTE': '1', 18:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:15 INFO - 'NO_EM_RESTART': '1', 18:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:15 INFO - 'PWD': '/builds/slave/test', 18:38:15 INFO - 'SHELL': '/bin/bash', 18:38:15 INFO - 'SHLVL': '1', 18:38:15 INFO - 'TERM': 'linux', 18:38:15 INFO - 'TMOUT': '86400', 18:38:15 INFO - 'USER': 'cltbld', 18:38:15 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', 18:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:15 INFO - '_': '/tools/buildbot/bin/python'} 18:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:38: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:38: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:38: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:38: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:38:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:38:16 INFO - Installing collected packages: mozsystemmonitor 18:38:16 INFO - Running setup.py install for mozsystemmonitor 18:38:16 INFO - Successfully installed mozsystemmonitor 18:38:16 INFO - Cleaning up... 18:38:16 INFO - Return code: 0 18:38:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:38: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:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38: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:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38: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', '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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4aa30>, '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 0xd4b7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4bca0>, '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': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', '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:38: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:38: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 jsonschema==2.5.1 18:38:16 INFO - Using env: {'DISPLAY': ':0', 18:38:16 INFO - 'HOME': '/home/cltbld', 18:38:16 INFO - 'LANG': 'en_US.UTF-8', 18:38:16 INFO - 'LANGUAGE': 'en_US:en', 18:38:16 INFO - 'LOGNAME': 'cltbld', 18:38:16 INFO - 'MAIL': '/var/mail/cltbld', 18:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:16 INFO - 'MOZ_NO_REMOTE': '1', 18:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:16 INFO - 'NO_EM_RESTART': '1', 18:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:16 INFO - 'PWD': '/builds/slave/test', 18:38:16 INFO - 'SHELL': '/bin/bash', 18:38:16 INFO - 'SHLVL': '1', 18:38:16 INFO - 'TERM': 'linux', 18:38:16 INFO - 'TMOUT': '86400', 18:38:16 INFO - 'USER': 'cltbld', 18:38:16 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', 18:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:16 INFO - '_': '/tools/buildbot/bin/python'} 18:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:17 INFO - Downloading/unpacking jsonschema==2.5.1 18:38: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:38: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:38: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:38: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:38:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:38:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:38: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:38: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:38: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:38: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:38:18 INFO - Downloading functools32-3.2.3-2.tar.gz 18:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:38:18 INFO - warning: no files found matching '*.txt' 18:38:18 INFO - no previously-included directories found matching 'build' 18:38:18 INFO - no previously-included directories found matching 'dist' 18:38:18 INFO - no previously-included directories found matching '.git*' 18:38:18 INFO - Installing collected packages: jsonschema, functools32 18:38:18 INFO - Running setup.py install for functools32 18:38:18 INFO - warning: no files found matching '*.txt' 18:38:18 INFO - no previously-included directories found matching 'build' 18:38:18 INFO - no previously-included directories found matching 'dist' 18:38:18 INFO - no previously-included directories found matching '.git*' 18:38:18 INFO - Successfully installed jsonschema functools32 18:38:18 INFO - Cleaning up... 18:38:18 INFO - Return code: 0 18:38:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4aa30>, '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 0xd4b7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4bca0>, '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': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', '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:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:38:18 INFO - Using env: {'DISPLAY': ':0', 18:38:18 INFO - 'HOME': '/home/cltbld', 18:38:18 INFO - 'LANG': 'en_US.UTF-8', 18:38:18 INFO - 'LANGUAGE': 'en_US:en', 18:38:18 INFO - 'LOGNAME': 'cltbld', 18:38:18 INFO - 'MAIL': '/var/mail/cltbld', 18:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:18 INFO - 'MOZ_NO_REMOTE': '1', 18:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:18 INFO - 'NO_EM_RESTART': '1', 18:38:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:18 INFO - 'PWD': '/builds/slave/test', 18:38:18 INFO - 'SHELL': '/bin/bash', 18:38:18 INFO - 'SHLVL': '1', 18:38:18 INFO - 'TERM': 'linux', 18:38:18 INFO - 'TMOUT': '86400', 18:38:18 INFO - 'USER': 'cltbld', 18:38:18 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', 18:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:18 INFO - '_': '/tools/buildbot/bin/python'} 18:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:38:18 INFO - Cleaning up... 18:38:18 INFO - Return code: 0 18:38:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4aa30>, '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 0xd4b7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4bca0>, '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': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', '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:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:38:18 INFO - Using env: {'DISPLAY': ':0', 18:38:18 INFO - 'HOME': '/home/cltbld', 18:38:18 INFO - 'LANG': 'en_US.UTF-8', 18:38:18 INFO - 'LANGUAGE': 'en_US:en', 18:38:18 INFO - 'LOGNAME': 'cltbld', 18:38:18 INFO - 'MAIL': '/var/mail/cltbld', 18:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:18 INFO - 'MOZ_NO_REMOTE': '1', 18:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:18 INFO - 'NO_EM_RESTART': '1', 18:38:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:18 INFO - 'PWD': '/builds/slave/test', 18:38:18 INFO - 'SHELL': '/bin/bash', 18:38:18 INFO - 'SHLVL': '1', 18:38:18 INFO - 'TERM': 'linux', 18:38:18 INFO - 'TMOUT': '86400', 18:38:18 INFO - 'USER': 'cltbld', 18:38:18 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', 18:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:18 INFO - '_': '/tools/buildbot/bin/python'} 18:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:19 INFO - Downloading/unpacking blobuploader==1.2.4 18:38:19 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:38:19 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:38:19 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:38:19 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:38:20 INFO - Downloading blobuploader-1.2.4.tar.gz 18:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:38:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:38:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:20 INFO - Downloading docopt-0.6.1.tar.gz 18:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:38:20 INFO - Installing collected packages: blobuploader, requests, docopt 18:38:20 INFO - Running setup.py install for blobuploader 18:38:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:38:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:38:20 INFO - Running setup.py install for requests 18:38:21 INFO - Running setup.py install for docopt 18:38:21 INFO - Successfully installed blobuploader requests docopt 18:38:21 INFO - Cleaning up... 18:38:21 INFO - Return code: 0 18:38:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:21 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4aa30>, '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 0xd4b7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4bca0>, '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': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', '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:38:21 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:38:21 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:38:21 INFO - Using env: {'DISPLAY': ':0', 18:38:21 INFO - 'HOME': '/home/cltbld', 18:38:21 INFO - 'LANG': 'en_US.UTF-8', 18:38:21 INFO - 'LANGUAGE': 'en_US:en', 18:38:21 INFO - 'LOGNAME': 'cltbld', 18:38:21 INFO - 'MAIL': '/var/mail/cltbld', 18:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:21 INFO - 'MOZ_NO_REMOTE': '1', 18:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:21 INFO - 'NO_EM_RESTART': '1', 18:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:21 INFO - 'PWD': '/builds/slave/test', 18:38:21 INFO - 'SHELL': '/bin/bash', 18:38:21 INFO - 'SHLVL': '1', 18:38:21 INFO - 'TERM': 'linux', 18:38:21 INFO - 'TMOUT': '86400', 18:38:21 INFO - 'USER': 'cltbld', 18:38:21 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', 18:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:21 INFO - '_': '/tools/buildbot/bin/python'} 18:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:21 INFO - Running setup.py (path:/tmp/pip-DGjRli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:21 INFO - Running setup.py (path:/tmp/pip-bZACAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:21 INFO - Running setup.py (path:/tmp/pip-1zBz47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:21 INFO - Running setup.py (path:/tmp/pip-_Z4lDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:21 INFO - Running setup.py (path:/tmp/pip-fZepqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:21 INFO - Running setup.py (path:/tmp/pip-47iIfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:22 INFO - Running setup.py (path:/tmp/pip-mCCDU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:22 INFO - Running setup.py (path:/tmp/pip-bfvoz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:22 INFO - Running setup.py (path:/tmp/pip-shh5qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:22 INFO - Running setup.py (path:/tmp/pip-1SG9fA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:22 INFO - Running setup.py (path:/tmp/pip-VIw_mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:22 INFO - Running setup.py (path:/tmp/pip-gtk3Ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:22 INFO - Running setup.py (path:/tmp/pip-sA8RW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:22 INFO - Running setup.py (path:/tmp/pip-HluK3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:22 INFO - Running setup.py (path:/tmp/pip-Uu8oq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:22 INFO - Running setup.py (path:/tmp/pip-AYwqNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:22 INFO - Running setup.py (path:/tmp/pip-mOJohL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:38:22 INFO - Running setup.py install for manifestparser 18:38:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:38:22 INFO - Running setup.py install for mozcrash 18:38:23 INFO - Running setup.py install for mozdebug 18:38:23 INFO - Running setup.py install for mozdevice 18:38:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:38:23 INFO - Running setup.py install for mozfile 18:38:23 INFO - Running setup.py install for mozhttpd 18:38:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:38:23 INFO - Running setup.py install for mozinfo 18:38:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:38:23 INFO - Running setup.py install for mozInstall 18:38:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:38:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:38:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:38:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:38:23 INFO - Running setup.py install for mozleak 18:38:23 INFO - Running setup.py install for mozlog 18:38:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:38:23 INFO - Running setup.py install for moznetwork 18:38:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:38:23 INFO - Running setup.py install for mozprocess 18:38:24 INFO - Running setup.py install for mozprofile 18:38:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:38:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:38:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:38:24 INFO - Running setup.py install for mozrunner 18:38:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:38:24 INFO - Running setup.py install for mozscreenshot 18:38:24 INFO - Running setup.py install for moztest 18:38:24 INFO - Running setup.py install for mozversion 18:38:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:38:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:38:24 INFO - Cleaning up... 18:38:24 INFO - Return code: 0 18:38:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:24 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4aa30>, '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 0xd4b7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4bca0>, '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': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', '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:38:24 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:38:24 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:38:24 INFO - Using env: {'DISPLAY': ':0', 18:38:24 INFO - 'HOME': '/home/cltbld', 18:38:24 INFO - 'LANG': 'en_US.UTF-8', 18:38:24 INFO - 'LANGUAGE': 'en_US:en', 18:38:24 INFO - 'LOGNAME': 'cltbld', 18:38:24 INFO - 'MAIL': '/var/mail/cltbld', 18:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:24 INFO - 'MOZ_NO_REMOTE': '1', 18:38:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:24 INFO - 'NO_EM_RESTART': '1', 18:38:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:24 INFO - 'PWD': '/builds/slave/test', 18:38:24 INFO - 'SHELL': '/bin/bash', 18:38:24 INFO - 'SHLVL': '1', 18:38:24 INFO - 'TERM': 'linux', 18:38:24 INFO - 'TMOUT': '86400', 18:38:24 INFO - 'USER': 'cltbld', 18:38:24 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', 18:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:24 INFO - '_': '/tools/buildbot/bin/python'} 18:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:24 INFO - Running setup.py (path:/tmp/pip-r4yh9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:24 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:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:24 INFO - Running setup.py (path:/tmp/pip-RBw8Ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:24 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:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:24 INFO - Running setup.py (path:/tmp/pip-3MAWKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:25 INFO - Running setup.py (path:/tmp/pip-ik68ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:25 INFO - Running setup.py (path:/tmp/pip-FD2mWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:25 INFO - Running setup.py (path:/tmp/pip-a5diXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:25 INFO - Running setup.py (path:/tmp/pip-8FBE0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:25 INFO - Running setup.py (path:/tmp/pip-D4Y0rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:25 INFO - Running setup.py (path:/tmp/pip-yaUkcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:25 INFO - Running setup.py (path:/tmp/pip-sKUsUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:25 INFO - Running setup.py (path:/tmp/pip-dEquTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:25 INFO - Running setup.py (path:/tmp/pip-bBTRry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:25 INFO - Running setup.py (path:/tmp/pip-b5GI2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:25 INFO - Running setup.py (path:/tmp/pip-jb_Dwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:25 INFO - Running setup.py (path:/tmp/pip-WZ5rvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:25 INFO - Running setup.py (path:/tmp/pip-lFAxdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:25 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:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:26 INFO - Running setup.py (path:/tmp/pip-GdsWs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:26 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:38:26 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:38:26 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:38:26 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:38:26 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:38:26 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:38:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:27 INFO - Downloading blessings-1.6.tar.gz 18:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:38:27 INFO - Installing collected packages: blessings 18:38:27 INFO - Running setup.py install for blessings 18:38:27 INFO - Successfully installed blessings 18:38:27 INFO - Cleaning up... 18:38:27 INFO - Return code: 0 18:38:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:38:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:27 INFO - Reading from file tmpfile_stdout 18:38:27 INFO - Current package versions: 18:38:27 INFO - argparse == 1.2.1 18:38:27 INFO - blessings == 1.6 18:38:27 INFO - blobuploader == 1.2.4 18:38:27 INFO - docopt == 0.6.1 18:38:27 INFO - functools32 == 3.2.3-2 18:38:27 INFO - jsonschema == 2.5.1 18:38:27 INFO - manifestparser == 1.1 18:38:27 INFO - mozInstall == 1.12 18:38:27 INFO - mozcrash == 1.0 18:38:27 INFO - mozdebug == 0.1 18:38:27 INFO - mozdevice == 0.50 18:38:27 INFO - mozfile == 1.2 18:38:27 INFO - mozhttpd == 0.7 18:38:27 INFO - mozinfo == 0.9 18:38:27 INFO - mozleak == 0.1 18:38:27 INFO - mozlog == 3.4 18:38:27 INFO - moznetwork == 0.27 18:38:27 INFO - mozprocess == 0.25 18:38:27 INFO - mozprofile == 0.28 18:38:27 INFO - mozrunner == 6.13 18:38:27 INFO - mozscreenshot == 0.1 18:38:27 INFO - mozsystemmonitor == 0.3 18:38:27 INFO - moztest == 0.8 18:38:27 INFO - mozversion == 1.4 18:38:27 INFO - psutil == 3.1.1 18:38:27 INFO - requests == 1.2.3 18:38:27 INFO - wsgiref == 0.1.2 18:38:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:27 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4aa30>, '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 0xd4b7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4bca0>, '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': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', '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:38:27 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:38:27 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:38:27 INFO - Using env: {'DISPLAY': ':0', 18:38:27 INFO - 'HOME': '/home/cltbld', 18:38:27 INFO - 'LANG': 'en_US.UTF-8', 18:38:27 INFO - 'LANGUAGE': 'en_US:en', 18:38:27 INFO - 'LOGNAME': 'cltbld', 18:38:27 INFO - 'MAIL': '/var/mail/cltbld', 18:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:27 INFO - 'MOZ_NO_REMOTE': '1', 18:38:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:27 INFO - 'NO_EM_RESTART': '1', 18:38:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:27 INFO - 'PWD': '/builds/slave/test', 18:38:27 INFO - 'SHELL': '/bin/bash', 18:38:27 INFO - 'SHLVL': '1', 18:38:27 INFO - 'TERM': 'linux', 18:38:27 INFO - 'TMOUT': '86400', 18:38:27 INFO - 'USER': 'cltbld', 18:38:27 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', 18:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:27 INFO - '_': '/tools/buildbot/bin/python'} 18:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:27 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:38:27 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:38:27 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:38:27 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:38:27 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:38:27 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:38:27 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:38:27 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:38:27 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:38:27 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:38:27 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:38:27 INFO - Cleaning up... 18:38:27 INFO - Return code: 0 18:38:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:27 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 0x9db1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4d770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd4aa30>, '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 0xd4b7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4bca0>, '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': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', '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:38:27 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:38:27 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:38:27 INFO - Using env: {'DISPLAY': ':0', 18:38:27 INFO - 'HOME': '/home/cltbld', 18:38:27 INFO - 'LANG': 'en_US.UTF-8', 18:38:27 INFO - 'LANGUAGE': 'en_US:en', 18:38:27 INFO - 'LOGNAME': 'cltbld', 18:38:27 INFO - 'MAIL': '/var/mail/cltbld', 18:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:27 INFO - 'MOZ_NO_REMOTE': '1', 18:38:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:27 INFO - 'NO_EM_RESTART': '1', 18:38:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:27 INFO - 'PWD': '/builds/slave/test', 18:38:27 INFO - 'SHELL': '/bin/bash', 18:38:27 INFO - 'SHLVL': '1', 18:38:27 INFO - 'TERM': 'linux', 18:38:27 INFO - 'TMOUT': '86400', 18:38:27 INFO - 'USER': 'cltbld', 18:38:27 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', 18:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:27 INFO - '_': '/tools/buildbot/bin/python'} 18:38:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:38:28 INFO - Cleaning up... 18:38:28 INFO - Return code: 0 18:38:28 INFO - Running post-action listener: _resource_record_post_action 18:38:28 INFO - Running post-action listener: _start_resource_monitoring 18:38:28 INFO - Starting resource monitoring. 18:38:28 INFO - [mozharness: 2017-05-12 01:38:28.068390Z] Finished create-virtualenv step (success) 18:38:28 INFO - [mozharness: 2017-05-12 01:38:28.068862Z] Running install step. 18:38:28 INFO - Running pre-action listener: _resource_record_pre_action 18:38:28 INFO - Running main action method: install 18:38:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:28 INFO - Reading from file tmpfile_stdout 18:38:28 INFO - Detecting whether we're running mozinstall >=1.0... 18:38:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:38:28 INFO - Reading from file tmpfile_stdout 18:38:28 INFO - Output received: 18:38:28 INFO - Usage: mozinstall [options] installer 18:38:28 INFO - Options: 18:38:28 INFO - -h, --help show this help message and exit 18:38:28 INFO - -d DEST, --destination=DEST 18:38:28 INFO - Directory to install application into. [default: 18:38:28 INFO - "/builds/slave/test"] 18:38:28 INFO - --app=APP Application being installed. [default: firefox] 18:38:28 INFO - mkdir: /builds/slave/test/build/application 18:38:28 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:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:38:45 INFO - Reading from file tmpfile_stdout 18:38:45 INFO - Output received: 18:38:45 INFO - /builds/slave/test/build/application/firefox/firefox 18:38:45 INFO - Running post-action listener: _resource_record_post_action 18:38:45 INFO - [mozharness: 2017-05-12 01:38:45.654151Z] Finished install step (success) 18:38:45 INFO - [mozharness: 2017-05-12 01:38:45.654397Z] Running run-tests step. 18:38:45 INFO - Running pre-action listener: _resource_record_pre_action 18:38:45 INFO - Running main action method: run_tests 18:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:38:45 INFO - Python 2.7.3 18:38:45 INFO - Return code: 0 18:38:45 INFO - grabbing minidump binary from tooltool 18:38:45 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:38:45 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 0xd4aa30>, '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 0xd4b7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd4bca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:38:45 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:38:45 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:38:45 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:38:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:38:45 INFO - Return code: 0 18:38:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:38:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:38:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:38:45 INFO - ENV: RUST_BACKTRACE is now 1 18:38:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:38:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-086 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:38:45 INFO - Using env: {'DISPLAY': ':0', 18:38:45 INFO - 'HOME': '/home/cltbld', 18:38:45 INFO - 'LANG': 'en_US.UTF-8', 18:38:45 INFO - 'LANGUAGE': 'en_US:en', 18:38:45 INFO - 'LOGNAME': 'cltbld', 18:38:45 INFO - 'MAIL': '/var/mail/cltbld', 18:38:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:38:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:45 INFO - 'MOZ_NO_REMOTE': '1', 18:38:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:45 INFO - 'NO_EM_RESTART': '1', 18:38:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:45 INFO - 'PWD': '/builds/slave/test', 18:38:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:38:45 INFO - 'RUST_BACKTRACE': '1', 18:38:45 INFO - 'SHELL': '/bin/bash', 18:38:45 INFO - 'SHLVL': '1', 18:38:45 INFO - 'TERM': 'linux', 18:38:45 INFO - 'TMOUT': '86400', 18:38:45 INFO - 'USER': 'cltbld', 18:38:45 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043', 18:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:45 INFO - '_': '/tools/buildbot/bin/python'} 18:38:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:38:45 INFO - mozversion application_buildid: 20170512003303 18:38:45 INFO - mozversion application_changeset: 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc 18:38:45 INFO - mozversion application_display_name: Nightly 18:38:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:38:45 INFO - mozversion application_name: Firefox 18:38:45 INFO - mozversion application_remotingname: firefox 18:38:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:38:45 INFO - mozversion application_vendor: Mozilla 18:38:45 INFO - mozversion application_version: 55.0a1 18:38:45 INFO - mozversion platform_buildid: 20170512003303 18:38:45 INFO - mozversion platform_changeset: 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc 18:38:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:38:45 INFO - mozversion platform_version: 55.0a1 18:38:45 INFO - using testdate: 1494553125 18:38:45 INFO - actual date: 1494553125 18:38:45 INFO - starting webserver on 'localhost:54572' 18:38:45 INFO - SUITE-START | Running 2 tests 18:38:45 INFO - TEST-START | dromaeo_css 18:38:45 INFO - operating with platform_type : linux_ 18:38:45 INFO - Initialising browser for dromaeo_css test... 18:38:45 INFO - TEST-INFO | started process 25040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDcVJdW/profile http://localhost:54572/getInfo.html) 18:38:49 INFO - PID 25040 | __metrics Screen width/height:1600/1200 18:38:49 INFO - PID 25040 | colorDepth:24 18:38:49 INFO - PID 25040 | Browser inner width/height: 1024/695 18:38:49 INFO - PID 25040 | __metrics 18:38:50 INFO - PID 25040 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:38:50 INFO - PID 25040 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:38:51 INFO - TEST-INFO | 25040: exit 0 18:38:51 INFO - Browser initialized. 18:38:51 INFO - Running cycle 1/1 for dromaeo_css test... 18:38:51 INFO - TEST-INFO | started process 25138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDcVJdW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:39:02 INFO - PID 25138 | RSS: Main: 144334848 18:39:02 INFO - PID 25138 | 18:42:04 INFO - PID 25138 | Cycle 1(1): loaded http://localhost:54572/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54572/tests/dromaeo/cssquery-ext.html) 18:42:06 INFO - PID 25138 | RSS: Main: 274714624 18:42:06 INFO - PID 25138 | 18:45:08 INFO - PID 25138 | Cycle 1(1): loaded http://localhost:54572/tests/dromaeo/cssquery-ext.html (next: http://localhost:54572/tests/dromaeo/cssquery-jquery.html) 18:45:08 INFO - PID 25138 | RSS: Main: 224931840 18:45:08 INFO - PID 25138 | 18:48:10 INFO - PID 25138 | Cycle 1(1): loaded http://localhost:54572/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54572/tests/dromaeo/cssquery-mootools.html) 18:48:11 INFO - PID 25138 | RSS: Main: 215490560 18:48:11 INFO - PID 25138 | 18:51:13 INFO - PID 25138 | Cycle 1(1): loaded http://localhost:54572/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54572/tests/dromaeo/cssquery-prototype.html) 18:51:13 INFO - PID 25138 | RSS: Main: 182358016 18:51:13 INFO - PID 25138 | 18:54:16 INFO - PID 25138 | Cycle 1(1): loaded http://localhost:54572/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54572/tests/dromaeo/cssquery-yui.html) 18:54:17 INFO - PID 25138 | RSS: Main: 177287168 18:54:17 INFO - PID 25138 | 18:57:18 INFO - PID 25138 | Cycle 1(1): loaded http://localhost:54572/tests/dromaeo/cssquery-yui.html (next: http://localhost:54572/tests/dromaeo/cssquery-dojo.html) 18:57:19 INFO - PID 25138 | RSS: Main: 266575872 18:57:19 INFO - PID 25138 | 18:57:19 INFO - PID 25138 | __start_tp_report 18:57:19 INFO - PID 25138 | _x_x_mozilla_page_load 18:57:19 INFO - PID 25138 | _x_x_mozilla_page_load_details 18:57:19 INFO - PID 25138 | |i|pagename|runs| 18:57:19 INFO - PID 25138 | |0;dojo.html;3231.466807976684;3235.6764323567645;3251.5285283633875;3262.820544870031;3290.720288775454;5683.488486036256;5733.369329373765;5787;5795.710214489269;5858.648481091138;5792.536597072235;5825.679587622679;5846.356900740915;5904.143899134623;5962.8807423851495;4835.588974937117;5069.44236134025;5151.845444636658;5218.634695571312;5257.737113144328;5211.400688920785;5215.921761173586;5286.286351342577;5308.734563271841;5309.41596424393;5067.189249720045;5136.5890728741615;5138.306328645623;5145.819896303611;5150.3047088642925;5175.223716442526;5198.896022079537;5231.450697676765;5268.972550352682;5271.604629652753;5176.611754118456;5178.922316165261;5187;5190.506901844356;5231;5664.716764161775;5748.827535173909;5811.215485909391;5818.709064546756;5825.679587622679;6139.124180917356;6246.968765156145;6251.593646412968;6254.155688981975;6258.374162583751;6326.367363263683;6333.366663333676;6340.175777148941;6346.428821406095;6348.301686814447;5720.1991721159075;5788.450097240798;5852.239208902858;5857.092150716646;5858.505564387951;6287.968560157261;6297.716602752796;6389.456896163785;6434.163558737334;6442.387973142544;5978.222831031938;6061.212042434456;6064.272287325549;6067.696615169224;6120.632762034292;6149.2313460817395;6162.22972128484;6182.165407669997;6200.689965501707;6230.7819226326865;6250.874982500324;6323.051542268697;6324.399182077787;6330.39861213184;6330.968345158245;6076.240469941257;6315.621062736251;6327.3988971047675;6331.27190373113;6342.841428964312;4687.929681054787;4742.762861856962;4764.785584648699;4765.451973023147;4767.070421267819;4268.210381079511;4268.658507319407;4268.765217913045;4272.615464608138;4310.590493903074;5894.764209431661;5895.174675545427;5901.793437229677;5901.940980590225;5907.763689452374;6120.724567394478;6159.1069294951985;6223.657698826518;6289.685515724195;6291.559590828598;5847.415258474119;5914.792982245601;5918.792842250587;5930.970345148333;5967.045272756338;5501;5506.33923929123;5506.697131657797;5506.972465137648;5508.6970216637665;6364.077208804697;6430.64631445275;6494.870102598016;6516.6415847128865;6627.900581491282;6308.716107775253;6338.683065846597;6340.397662222082;6347.68261586928;6354.777582784581;6524.314946930694;6577.704003319766;6602.306757790363;6608.372204640552;6611.404973552403;6086.178365920544;6107.755689772359;6128.816135515942;6233;6236.563440559117;6286.497080233479;6287.654179020198;6327.778527751507;6336.873262534816;6339.556231063966;6147.600405973598;6149.169862068742;6150.7847225346895;6154.846128846814;6158.291796443466;5998.970005149947;6016.669083200466;6072.089186622042;6091.177691011657;6148.292946311052;6095.136089334496;6095.691643723386;6107.450329470191;6124.8775024500155;6131.4481696645735;6121.265448146251;6126.426068710427;6130.356312587114;6136.6011209271255;6137.478314343331;5903.822885313448;5940.46535811779;5952.642841429355;5954.10688396744;5956.434138756811 18:57:19 INFO - PID 25138 | |1;ext.html;749.6813854112002;814.1654803826078;836.5399030533205;1126.7633796902655;1133.648568943628;29298.85350573247;29793.255168620795;33345.99999999997;33959.490607640844;34088.31823363531;35965;36316.81841590788;36339.27321453576;36341.27317453656;36360.63639363612;5569.832905012856;6979.057827193315;7104.786856394317;7109.573425594455;7112.573245605255;5660.745266463019;7057.576545407292;7180.425565954737;7188.353048225658;7188.676509557056;7276.272372762734;7290.198078211392;7296.452766042542;7308.415326773846;7310.707571697152;5553.8333849984565;7200.207977122539;7271.454640901953;7275.454340924452;7281.927180728205;5642.971785141048;7017.649117544102;7084;7090.432765378758;7091.290870912868;35697;36001.279974400364;36005.45991810125;36021.279574408625;36086.458703119475;3474.7567670263093;3506.0533655913014;3517.103138699641;3520.647935206459;3523.4186359250693;28392.432151357065;28493.715062849522;28548;28574;28613.427731445463;3722.1066943933533;3765.152840610868;3768.773873567567;3791.052236940765;3827.942580861289;194873;195430;196686.01656991767;197025;197267;47467.28799068017;47576.145431274235;47666.285005724945;47722;47741;48711.75644121828;48955.776105597644;49179.75410122998;49181.50818491769;49277.507224928006;14554.563363099123;14670.413183472541;14695.11829290246;14695.853041469662;14699.338529766186;10559.736006599896;10704.839427408595;11890.28658280506;11938;12003.219790713576;11273.154513411528;11362.375069371099;14625.853741462663;14707.92646036763;14890.553283401516;5741.655500669973;5752.36723960364;5807.332156802022;5813.6221145625395;5863.120531920246;1054.8839627640953;1095.2771171027084;1095.4905968724422;1108.0747575774158;1110.4947249001684;26436.517376137923;26652.866735666197;26934;26966.595501067106;27013.324666883484;1183.2841131115551;1192.8568571771443;1193.4569770754285;1214.9149559530924;1228.619128070301;13371.799423008662;13653.931730341284;13679.452821887213;13748.93125534386;13834.65413364674;249107;249991;252316;252347;253401;51703.43486455018;51836.22245666243;51988.48011519836;52028.21957670638;52055;1435.2751860310477;1498.685276092011;1515.636247300662;1515.7423238049557;1527.2058529564565;23556.764432355456;24765.504689906462;25001.999920002996;25028.749712502642;29686;49182.26226606532;49631.25553116634;49646.50353496419;49678.751606241734;49715.25427118524;216416;217423;218794;219147;219711;34709.140720298674;34769;35158.29683406369;35255.471167933014;35264.647353527165;41350.1729965405;43477.13045739131;43505.51955843588;43601;43657.781711091244;30609.54085688761;30737.846310769197;32063.190521421973;32537.674623253464;32665.18337041593;31352;31675.366492670477;32421.18947026343;32484.18789530186;33092.669073308956;37328.62671373251;37479.81260093682;37488.437673434375;37508.43737343887;37512.249755005294;29696.703032970257;30551.847240763655;30728.385432291678;30928.53607195939;31238.375232494767;24326.51346973086;25538.361540961625;25840.741592584585;26098.217053488424;26188.476230474902 18:57:19 INFO - PID 25138 | |2;jquery.html;387.2081593142024;451.28246088718953;461.4485689600926;462.56056746091224;474.5610310462822;18677.346292879716;18682.252709891603;19100.522486937833;19136.521586960316;19177.904110479445;20542.486437839063;21247.57504849902;21430.785692143072;21562.353129406103;21757.564848703016;5417.810376636819;5626.493615574597;5628.577856660746;5632.098864181732;5637.3517045539675;5344.064788661988;5518.33779946405;5548.334199895998;5551.72241387931;5553.389127196006;5334.066538355792;5490.478404551562;5490.670559766427;5521.033819081665;5524.889502209953;5446.556662484445;5473.67157970523;5513.145462453286;5534.280543529356;5535.142052981774;4934.062528119646;5002.049610573979;5002.1496345621335;5006.274090256892;5042.520960508746;25324.746752532425;25768.613470797955;25886.093986710373;25899.611505827426;26255.606165907528;2045.4886278430392;2098.6642137257963;2107.557412943284;2129.127057906251;2140.9571808563896;16651.91674041622;16877.32490700383;17004;17118.058506782123;17122.40071597488;2131.531063166101;2159.88120653364;2204.691343211952;2212.6017316882953;2242.0583354990945;110146.44926775395;110793.10551438962;115600.42199789031;117798.41100794527;121107.9064048028;11434.371109588887;12452.875471245172;12552.246865188117;12611.747765044647;12823.294718790556;17394.652106958045;17621.383251586132;17689.46931592054;17755.289788408318;17866.374676886247;8812.911870881337;8920.375573709778;8935.865962010575;8949.910500894908;9198.080191980882;8284;8404.915950840414;8514.57427128641;8553.486790792573;8594.87107693385;7858.410619203582;7886.684532618746;8067.515949043076;8093.392995525359;8128.431009829374;2222.655488399301;2247.763984781607;2254.5490901819376;2268.88655567221;2358.3750306168877;1018.3024628129607;1030.5414090729703;1048.1038711901215;1048.99475502622;1058.3226734889677;18615.126650725786;19991.40025799228;20027.399178024683;20116.29592964239;20177.092030858646;1056.5140035583718;1057.2070946789909;1059.1103473082649;1071.973200669974;1076.8869268726671;10520.998415213886;10895.509702063426;10906.672799816019;10925.945370273097;10945.890541094486;446916;447247;448164;468519;473211;92913.53543232376;95355;96708;97308;98058;1184.8163534652142;1196.9940150299367;1235.950561977511;1236.5548402575066;1250.6998320403038;16285.104319262555;16692.916535417244;16757.1621418931;16852.747208791632;16965;43670.344944825214;44605.77697111494;44941;45743.77128114338;46815.53184468248;56414;57698.711506442196;58735;59033.70483147557;59223.703881480316;9204.95397523008;9260.444373337621;9260.814783704154;9329.766755831159;9683.612655493702;14718.926405367905;14880.577467182826;14982.550523484313;15094.54716358511;15414.614634634223;12669;12799;12819.615411537668;12921.289329086614;13143.73712525725;11506.884931150917;12377.938110309751;12710.618681439571;12988.415521301375;13092.672683182996;13185;13294.933525332312;13368.197908125543;13442.260675662541;13547.390367433292;9238.30712696537;9289.489078100769;9366.859497107413;9482.620695172116;9565.665201717906;12072.154949153475;12123.211991220542;12669.873301266869;12822.487100516248;13133.212007279593 18:57:19 INFO - PID 25138 | |3;mootools.html;1347.4138749643905;1389.7290028444452;1407.0572716280092;1415.4055296775352;1417.6455886028493;11475.139364547662;11907;11926.344051077198;11930.76138477232;11931.880681193195;11621.12841536884;11715.882841171586;11863.7627247455;11945.940270298657;11948.462319195636;2423.951520969584;2460.778529932306;2464.544059349017;2465.802735781142;2469.4320306329555;1969.6257711034857;2357.5520651076326;2391.8445301055376;2406;2412.6984126984125;2073.243266207831;2323.732770731362;2428.514297140579;2446.571849926265;2446.963295550568;2373.4066483379156;2384.0582969726947;2394.1022116706235;2395.3532546212514;2397.44858682504;2303.4356582637192;2365.47959448921;2367.3963139399343;2368.218487898989;2368.8984622150783;11502.079833613374;11594.304341739438;11595.188336816425;11603.245789023686;11606.477708503138;6420.357964203589;6628.767993120217;6630.104935833649;6633.4693224541925;6640.33596640337;3705.7035437164964;3889.5138107736534;4108.568600296986;4111.876643700693;4143.854965076208;1423.6939058102557;1427.807246021784;1464.1068947941747;1515.2272341106004;1528.5032364481588;17802.198901049484;17944.282228710836;17958.910205449152;17988.55028624282;17999.19003644826;5121.8719532011255;5184.338125508703;5371.865703357447;5422.91865622016;5471.37079235893;12600.747985040249;12632;12683.556075537497;12692.555760548337;12695.492180312684;6505.837354066186;6511.15355003856;6512.088307636935;6513.511486638521;6515.967420162869;5961.612495187799;6144.754209831646;6205.875882482325;6281.8743625127245;6283.7800676976085;4171.498260626172;4292.205941900758;4347.413099231627;4387.934180987288;4460.955390446119;1049.8477720730452;1119.3563700871869;1141.1042331769522;1151.1308961733837;1153.7366583590954;655.6361219523116;805.7341077444429;839.2866063845682;848.4993853626266;884.7964968057254;5997.850053748692;6217.782377616762;6251.6561589112125;6333.588316759396;6372.490200783926;971.1550950672819;973.4694591447678;982.4989255479613;990.7968866382374;1009.535613617744;3841.366174581163;3893.182431689377;3927.5286965564314;3973.920521589552;3985.501812273466;15333.616659583377;15884.444044458389;15905.602359940862;15999.440019599258;16013.279402426919;15013.099214047192;15576.221188940508;15675.686486270211;15693.45072922465;15714.842851571566;9215.308851836138;9443.480608566595;9448.433094014381;9448.763780905532;9460.2904782143;6696.665166741741;7257.745978890714;7263.4915555910575;7312.15910170316;7431.925680743123;13301.866981330062;13469.663258418617;13977.58067257984;13990.930045349709;14010.43958241659;13749.450021999008;13852.307384630929;13983.230922299372;14086.859131408555;14254.786178207543;9257.953710231406;9411.576479058322;9428.528573571431;9434.528273586431;9440.244780417413;11288.604898828502;11651.766964660828;11753.529858805552;11763.705907352385;11783.941080294544;9306.208972237435;9374.765630859283;9504.809903801746;9565.139137477661;9832.262580306362;9131.863022054808;9215;9326.393784403992;9401;9586.568604412678;8493;8642.265407440438;8664.176903194186;8688;8688.52213128284;5903.793367232126;5939.881202376015;5947.553933454921;6008.669523176267;6105.877882442415;6032.75868965254;6091.9086213707715;6149.692515374303;6157.107219453064;6163.84590385244 18:57:19 INFO - PID 25138 | |4;prototype.html;397.9243943650708;406.4269380173955;428.45158197507203;430.47267097805195;434.20757118259183;5612.7754889804355;5756.395578464264;5864.589478736485;5903.2916050074;5909.645421274727;5618.999090809183;5773.162891380747;5788.6816225107605;5795.420457954203;5805.883882322361;4613.561711637398;4626.560476754703;4647.86056418308;4648.953510464903;4671.159191345557;4293.892652683677;4594.47163576188;4650.441946966369;4651.790669419867;4664.787155339619;4586.325991013273;4590.472095709003;4591.47198072221;4592.977035114836;4604.125216208927;4594.517575654559;4602.355670206174;4608.74651894144;4609.03210325832;4621.884452888705;4150.667946564267;4170.91658166838;4173.4157217989505;4180.163967206571;4184.330507118846;5647.661140331593;5660.971695141539;5665.66006039639;5677.659340439587;5696.886062278772;5385.461453854622;5448.318960129984;5470.316210473691;5489.39616642169;5491.148871924858;6206.224221972254;6216.222972128484;6228.941080016408;6248.125262463259;6269.216347956505;4718.764061796896;4728.905421891577;4732.455767586703;4733.857984260478;4733.9763301183275;6199.566030377875;6332.176817013758;6366.236051673783;6387.552871299057;6399.392057754506;4852.126617208936;4866.343043689057;4874.2201247800895;4883.780229889663;4889.731064791399;4942.654014218971;4952.925706114411;4953.405591328991;4953.925691114636;4967.726775027409;4964.801407943714;5161.303224064778;5208.244804503402;5211.635185536976;5450.127979523258;5889.146073819272;6204.937950620436;6207.34822843604;6211.65835879031;6218.160548326008;1490.8658220760183;1504.9322780474904;1541.4758981946193;1551.5655616427418;1555.175756848872;1023.8310678737924;1031.896810318962;1044.3159730376615;1058.402002868377;1067.8505009298703;5808.273965754281;5848.5321174305955;5856.209411729362;5879.647221166658;5892.381299963442;6285.96857015712;6299.7085597452415;6313.779017734358;6315.368463153648;6349.777757778548;5725.198472213893;5822.656977089539;5829.8251052468495;5875.6474611523445;5896.457330109683;3306.6528014558608;3325.2518183409024;3362.176266814646;3364.61306949699;3372.5278461015478;6359.569096953241;6557.786809440268;6607.017894631687;6610.8016759497295;6629.734810607618;6492.577982431221;6521.64130972801;6522;6528.412442880163;6548.8362790930605;6379.202599675041;6585.934140658532;6613.603183808987;6623.503237257225;6643.734250630017;6355.332690067661;6359.682015899279;6359.90460143089;6394.848927192964;6403.2316122063785;6059.848503787441;6294.968525157345;6328.46208072319;6335.714892829741;6335.904961425675;6608.240052394036;6645.501587381063;6646.867062658816;6657.3342665733035;6664.833379165366;4445.955540444684;4463.888402789957;4473.776311184492;4474.306482495218;4478.104379124123;6067.726952287246;6204.100405441276;6240.656763878031;6369.777057802955;6376.449420231945;5983.790567330123;6129.724162412791;6140.017597184429;6152.384761523812;6153.753849845956;6055.515558755377;6140.815775526741;6145.985912324595;6153.753909802223;6189.288231853395;6099.3290738017895;6114.205153330038;6137.877242455215;6144.354842741448;6146.723397447036;6168.444839964424;6169.6683790752495;6193.721282542387;6200.286966998672;6202.937970620236;5802;5952.73212705438;5994.880102398015;5996.37038110992;6034.668093254913 18:57:19 INFO - PID 25138 | |5;yui.html;803.0443771911421;814.9470284431508;815.5310696349601;874.3835595904885;888.1961824548781;16706.916465417686;17372;17674.734878976826;17689.203985820637;17707.291708331682;16841.83158168418;17034.23345949432;17205.91397043013;17207.13964301786;17232.913835430805;984.4339504784724;1000.4297550396277;1003.6537394598888;1010.4644538394663;1011.2163073617932;1029.0327092533032;1029.3772267778;1029.5367084811865;1030.361176070837;1034.5344594932274;1013.944233067181;1047.9109275711573;1048;1050.6480329089763;1052.5789684126335;1015.8831734350533;1051.7107795356262;1053.936763794171;1054.7943151085542;1055.2033214922685;741.3994664321916;760.9695612175507;769.0310209136528;769.9807504812369;770.791886190731;15605.297761600641;15715.371385144696;15899.523014309589;15941.601459963478;16036;17140.228689708994;17228.195222265425;17811.821881781147;18107.094645267814;18116.63766724658;14758.926205369013;15064.246787660682;15101.3204405802;15119.09285442866;15216.543503694907;3547.4324108142832;3564.3049605326714;3569.0720412692885;3570.5715314162467;3573.4818451324672;82504;82699;83469.16530834675;84333.57833210856;84471.15528844694;14990.250487475583;15218.391264349524;15376.61558461025;15384.538463846102;15469;25980.22059338223;26758;27786;27791.16626501208;27835.02577409781;8006.639701213459;8237.382196335298;8238.8352232955;8250.669973201126;8265.429568381987;4016.9397459038137;4054.8580799671868;4075.2053349596545;4102.138550904284;4117.75293482392;4248.808803603845;4402.537733537996;4405.647548196137;4409.096135292258;4415.315626077963;864.9048604653483;867.9218870301577;868.7871471489399;870.3211495033884;880.0231742765525;647.2136354329513;647.2330288608015;655.3872129558878;659.152988409891;666.7866282789557;11288.435578221057;11515.712107197387;11534.769304613861;11638.1271404645;12393.938030309972;692.7817737412698;702.3608516250188;710;714.1501613080418;720.1538192623751;5525.557955363562;5548.834744703577;5578.9163162552595;5770.6249093808765;5932.79235226765;78201.21798782054;78467.60766196133;79285.60357198177;81967;84522;70923.2907670927;71486.28513714796;72606.27393726101;74769.6261518689;75066.62466687632;42854.785891058295;47597.28604070942;47827.52172478231;59499.405005950255;61560.38439615636;12372.690682733004;13280;13335.733285334432;13353.66615834612;13416.262105584286;33550.66449335475;33735.15662108467;34041;34147.65852341544;35310.47034294436;39934.80032599935;40500.79749601233;40547.59452405438;40860.38709419421;41748.58251417569;14807.851921480647;14843.92578037103;14931.701365972402;15064.698706026038;15117.697646046798;16738.748918765985;17476.475705728848;17479.47561573155;17498.91250543739;17599.472015839547;16230.837691622932;16701.749473758147;16785.748213777046;16832.57918552046;16930.068846213577;15897.52307430779;16128.193590320672;16178.919105404868;16427;16495.422660206834;15781.21093945321;15836.841631583997;15854.207289635702;16128.67742645164;16366.018038917702;11517.366544840113;11858.76282474363;11924.165308428674;11994.160408771302;12186.695332616755;13394.263315517741;13787.103838250883;13812.309384530934;13817.101888377223;13932.373043213283 18:57:19 INFO - PID 25138 | __end_tp_report 18:57:19 INFO - PID 25138 | __start_cc_report 18:57:19 INFO - PID 25138 | _x_x_mozilla_cycle_collect,1364 18:57:19 INFO - PID 25138 | __end_cc_report 18:57:19 INFO - PID 25138 | __startTimestamp1494554239054__endTimestamp 18:57:19 INFO - PID 25138 | 18:57:19 INFO - PID 25138 | ------- Summary: start ------- 18:57:19 INFO - PID 25138 | Number of tests: 6 18:57:19 INFO - PID 25138 | 18:57:19 INFO - PID 25138 | [#0] dojo.html Cycles:165 Average:5788.61 Median:6016.67 stddev:696.07 (11.6%) stddev-sans-first:668.68 18:57:19 INFO - PID 25138 | Values: 3231.5 3235.7 3251.5 3262.8 3290.7 5683.5 5733.4 5787.0 5795.7 5858.6 5792.5 5825.7 5846.4 5904.1 5962.9 4835.6 5069.4 5151.8 5218.6 5257.7 5211.4 5215.9 5286.3 5308.7 5309.4 5067.2 5136.6 5138.3 5145.8 5150.3 5175.2 5198.9 5231.5 5269.0 5271.6 5176.6 5178.9 5187.0 5190.5 5231.0 5664.7 5748.8 5811.2 5818.7 5825.7 6139.1 6247.0 6251.6 6254.2 6258.4 6326.4 6333.4 6340.2 6346.4 6348.3 5720.2 5788.5 5852.2 5857.1 5858.5 6288.0 6297.7 6389.5 6434.2 6442.4 5978.2 6061.2 6064.3 6067.7 6120.6 6149.2 6162.2 6182.2 6200.7 6230.8 6250.9 6323.1 6324.4 6330.4 6331.0 6076.2 6315.6 6327.4 6331.3 6342.8 4687.9 4742.8 4764.8 4765.5 4767.1 4268.2 4268.7 4268.8 4272.6 4310.6 5894.8 5895.2 5901.8 5901.9 5907.8 6120.7 6159.1 6223.7 6289.7 6291.6 5847.4 5914.8 5918.8 5931.0 5967.0 5501.0 5506.3 5506.7 5507.0 5508.7 6364.1 6430.6 6494.9 6516.6 6627.9 6308.7 6338.7 6340.4 6347.7 6354.8 6524.3 6577.7 6602.3 6608.4 6611.4 6086.2 6107.8 6128.8 6233.0 6236.6 6286.5 6287.7 6327.8 6336.9 6339.6 6147.6 6149.2 6150.8 6154.8 6158.3 5999.0 6016.7 6072.1 6091.2 6148.3 6095.1 6095.7 6107.5 6124.9 6131.4 6121.3 6126.4 6130.4 6136.6 6137.5 5903.8 5940.5 5952.6 5954.1 5956.4 18:57:19 INFO - PID 25138 | 18:57:19 INFO - PID 25138 | [#1] ext.html Cycles:180 Average:38631.85 Median:34023.90 stddev:58012.31 (170.5%) stddev-sans-first:58105.32 18:57:19 INFO - PID 25138 | Values: 749.7 814.2 836.5 1126.8 1133.6 29298.9 29793.3 33346.0 33959.5 34088.3 35965.0 36316.8 36339.3 36341.3 36360.6 5569.8 6979.1 7104.8 7109.6 7112.6 5660.7 7057.6 7180.4 7188.4 7188.7 7276.3 7290.2 7296.5 7308.4 7310.7 5553.8 7200.2 7271.5 7275.5 7281.9 5643.0 7017.6 7084.0 7090.4 7091.3 35697.0 36001.3 36005.5 36021.3 36086.5 3474.8 3506.1 3517.1 3520.6 3523.4 28392.4 28493.7 28548.0 28574.0 28613.4 3722.1 3765.2 3768.8 3791.1 3827.9 194873.0 195430.0 196686.0 197025.0 197267.0 47467.3 47576.1 47666.3 47722.0 47741.0 48711.8 48955.8 49179.8 49181.5 49277.5 14554.6 14670.4 14695.1 14695.9 14699.3 10559.7 10704.8 11890.3 11938.0 12003.2 11273.2 11362.4 14625.9 14707.9 14890.6 5741.7 5752.4 5807.3 5813.6 5863.1 1054.9 1095.3 1095.5 1108.1 1110.5 26436.5 26652.9 26934.0 26966.6 27013.3 1183.3 1192.9 1193.5 1214.9 1228.6 13371.8 13653.9 13679.5 13748.9 13834.7 249107.0 249991.0 252316.0 252347.0 253401.0 51703.4 51836.2 51988.5 52028.2 52055.0 1435.3 1498.7 1515.6 1515.7 1527.2 23556.8 24765.5 25002.0 25028.7 29686.0 49182.3 49631.3 49646.5 49678.8 49715.3 216416.0 217423.0 218794.0 219147.0 219711.0 34709.1 34769.0 35158.3 35255.5 35264.6 41350.2 43477.1 43505.5 43601.0 43657.8 30609.5 30737.8 32063.2 32537.7 32665.2 31352.0 31675.4 32421.2 32484.2 33092.7 37328.6 37479.8 37488.4 37508.4 37512.2 29696.7 30551.8 30728.4 30928.5 31238.4 24326.5 25538.4 25840.7 26098.2 26188.5 18:57:19 INFO - PID 25138 | 18:57:19 INFO - PID 25138 | [#2] jquery.html Cycles:180 Average:29991.64 Median:11958.72 stddev:76373.73 (638.6%) stddev-sans-first:76555.64 18:57:19 INFO - PID 25138 | Values: 387.2 451.3 461.4 462.6 474.6 18677.3 18682.3 19100.5 19136.5 19177.9 20542.5 21247.6 21430.8 21562.4 21757.6 5417.8 5626.5 5628.6 5632.1 5637.4 5344.1 5518.3 5548.3 5551.7 5553.4 5334.1 5490.5 5490.7 5521.0 5524.9 5446.6 5473.7 5513.1 5534.3 5535.1 4934.1 5002.0 5002.1 5006.3 5042.5 25324.7 25768.6 25886.1 25899.6 26255.6 2045.5 2098.7 2107.6 2129.1 2141.0 16651.9 16877.3 17004.0 17118.1 17122.4 2131.5 2159.9 2204.7 2212.6 2242.1 110146.4 110793.1 115600.4 117798.4 121107.9 11434.4 12452.9 12552.2 12611.7 12823.3 17394.7 17621.4 17689.5 17755.3 17866.4 8812.9 8920.4 8935.9 8949.9 9198.1 8284.0 8404.9 8514.6 8553.5 8594.9 7858.4 7886.7 8067.5 8093.4 8128.4 2222.7 2247.8 2254.5 2268.9 2358.4 1018.3 1030.5 1048.1 1049.0 1058.3 18615.1 19991.4 20027.4 20116.3 20177.1 1056.5 1057.2 1059.1 1072.0 1076.9 10521.0 10895.5 10906.7 10925.9 10945.9 446916.0 447247.0 448164.0 468519.0 473211.0 92913.5 95355.0 96708.0 97308.0 98058.0 1184.8 1197.0 1236.0 1236.6 1250.7 16285.1 16692.9 16757.2 16852.7 16965.0 43670.3 44605.8 44941.0 45743.8 46815.5 56414.0 57698.7 58735.0 59033.7 59223.7 9205.0 9260.4 9260.8 9329.8 9683.6 14718.9 14880.6 14982.6 15094.5 15414.6 12669.0 12799.0 12819.6 12921.3 13143.7 11506.9 12377.9 12710.6 12988.4 13092.7 13185.0 13294.9 13368.2 13442.3 13547.4 9238.3 9289.5 9366.9 9482.6 9565.7 12072.2 12123.2 12669.9 12822.5 13133.2 18:57:19 INFO - PID 25138 | 18:57:19 INFO - PID 25138 | [#3] mootools.html Cycles:180 Average:7301.74 Median:3087.57 stddev:4784.59 (155.0%) stddev-sans-first:4777.09 18:57:19 INFO - PID 25138 | Values: 1347.4 1389.7 1407.1 1415.4 1417.6 11475.1 11907.0 11926.3 11930.8 11931.9 11621.1 11715.9 11863.8 11945.9 11948.5 2424.0 2460.8 2464.5 2465.8 2469.4 1969.6 2357.6 2391.8 2406.0 2412.7 2073.2 2323.7 2428.5 2446.6 2447.0 2373.4 2384.1 2394.1 2395.4 2397.4 2303.4 2365.5 2367.4 2368.2 2368.9 11502.1 11594.3 11595.2 11603.2 11606.5 6420.4 6628.8 6630.1 6633.5 6640.3 3705.7 3889.5 4108.6 4111.9 4143.9 1423.7 1427.8 1464.1 1515.2 1528.5 17802.2 17944.3 17958.9 17988.6 17999.2 5121.9 5184.3 5371.9 5422.9 5471.4 12600.7 12632.0 12683.6 12692.6 12695.5 6505.8 6511.2 6512.1 6513.5 6516.0 5961.6 6144.8 6205.9 6281.9 6283.8 4171.5 4292.2 4347.4 4387.9 4461.0 1049.8 1119.4 1141.1 1151.1 1153.7 655.6 805.7 839.3 848.5 884.8 5997.9 6217.8 6251.7 6333.6 6372.5 971.2 973.5 982.5 990.8 1009.5 3841.4 3893.2 3927.5 3973.9 3985.5 15333.6 15884.4 15905.6 15999.4 16013.3 15013.1 15576.2 15675.7 15693.5 15714.8 9215.3 9443.5 9448.4 9448.8 9460.3 6696.7 7257.7 7263.5 7312.2 7431.9 13301.9 13469.7 13977.6 13990.9 14010.4 13749.5 13852.3 13983.2 14086.9 14254.8 9258.0 9411.6 9428.5 9434.5 9440.2 11288.6 11651.8 11753.5 11763.7 11783.9 9306.2 9374.8 9504.8 9565.1 9832.3 9131.9 9215.0 9326.4 9401.0 9586.6 8493.0 8642.3 8664.2 8688.0 8688.5 5903.8 5939.9 5947.6 6008.7 6105.9 6032.8 6091.9 6149.7 6157.1 6163.8 18:57:19 INFO - PID 25138 | 18:57:19 INFO - PID 25138 | [#4] prototype.html Cycles:180 Average:5229.58 Median:5826.24 stddev:1514.75 (26.0%) stddev-sans-first:1474.95 18:57:19 INFO - PID 25138 | Values: 397.9 406.4 428.5 430.5 434.2 5612.8 5756.4 5864.6 5903.3 5909.6 5619.0 5773.2 5788.7 5795.4 5805.9 4613.6 4626.6 4647.9 4649.0 4671.2 4293.9 4594.5 4650.4 4651.8 4664.8 4586.3 4590.5 4591.5 4593.0 4604.1 4594.5 4602.4 4608.7 4609.0 4621.9 4150.7 4170.9 4173.4 4180.2 4184.3 5647.7 5661.0 5665.7 5677.7 5696.9 5385.5 5448.3 5470.3 5489.4 5491.1 6206.2 6216.2 6228.9 6248.1 6269.2 4718.8 4728.9 4732.5 4733.9 4734.0 6199.6 6332.2 6366.2 6387.6 6399.4 4852.1 4866.3 4874.2 4883.8 4889.7 4942.7 4952.9 4953.4 4953.9 4967.7 4964.8 5161.3 5208.2 5211.6 5450.1 5889.1 6204.9 6207.3 6211.7 6218.2 1490.9 1504.9 1541.5 1551.6 1555.2 1023.8 1031.9 1044.3 1058.4 1067.9 5808.3 5848.5 5856.2 5879.6 5892.4 6286.0 6299.7 6313.8 6315.4 6349.8 5725.2 5822.7 5829.8 5875.6 5896.5 3306.7 3325.3 3362.2 3364.6 3372.5 6359.6 6557.8 6607.0 6610.8 6629.7 6492.6 6521.6 6522.0 6528.4 6548.8 6379.2 6585.9 6613.6 6623.5 6643.7 6355.3 6359.7 6359.9 6394.8 6403.2 6059.8 6295.0 6328.5 6335.7 6335.9 6608.2 6645.5 6646.9 6657.3 6664.8 4446.0 4463.9 4473.8 4474.3 4478.1 6067.7 6204.1 6240.7 6369.8 6376.4 5983.8 6129.7 6140.0 6152.4 6153.8 6055.5 6140.8 6146.0 6153.8 6189.3 6099.3 6114.2 6137.9 6144.4 6146.7 6168.4 6169.7 6193.7 6200.3 6202.9 5802.0 5952.7 5994.9 5996.4 6034.7 18:57:19 INFO - PID 25138 | 18:57:19 INFO - PID 25138 | [#5] yui.html Cycles:180 Average:18190.62 Median:17759.56 stddev:21741.09 (122.4%) stddev-sans-first:21762.87 18:57:19 INFO - PID 25138 | Values: 803.0 814.9 815.5 874.4 888.2 16706.9 17372.0 17674.7 17689.2 17707.3 16841.8 17034.2 17205.9 17207.1 17232.9 984.4 1000.4 1003.7 1010.5 1011.2 1029.0 1029.4 1029.5 1030.4 1034.5 1013.9 1047.9 1048.0 1050.6 1052.6 1015.9 1051.7 1053.9 1054.8 1055.2 741.4 761.0 769.0 770.0 770.8 15605.3 15715.4 15899.5 15941.6 16036.0 17140.2 17228.2 17811.8 18107.1 18116.6 14758.9 15064.2 15101.3 15119.1 15216.5 3547.4 3564.3 3569.1 3570.6 3573.5 82504.0 82699.0 83469.2 84333.6 84471.2 14990.3 15218.4 15376.6 15384.5 15469.0 25980.2 26758.0 27786.0 27791.2 27835.0 8006.6 8237.4 8238.8 8250.7 8265.4 4016.9 4054.9 4075.2 4102.1 4117.8 4248.8 4402.5 4405.6 4409.1 4415.3 864.9 867.9 868.8 870.3 880.0 647.2 647.2 655.4 659.2 666.8 11288.4 11515.7 11534.8 11638.1 12393.9 692.8 702.4 710.0 714.2 720.2 5525.6 5548.8 5578.9 5770.6 5932.8 78201.2 78467.6 79285.6 81967.0 84522.0 70923.3 71486.3 72606.3 74769.6 75066.6 42854.8 47597.3 47827.5 59499.4 61560.4 12372.7 13280.0 13335.7 13353.7 13416.3 33550.7 33735.2 34041.0 34147.7 35310.5 39934.8 40500.8 40547.6 40860.4 41748.6 14807.9 14843.9 14931.7 15064.7 15117.7 16738.7 17476.5 17479.5 17498.9 17599.5 16230.8 16701.7 16785.7 16832.6 16930.1 15897.5 16128.2 16178.9 16427.0 16495.4 15781.2 15836.8 15854.2 16128.7 16366.0 11517.4 11858.8 11924.2 11994.2 12186.7 13394.3 13787.1 13812.3 13817.1 13932.4 18:57:19 INFO - PID 25138 | -------- Summary: end -------- 18:57:19 INFO - PID 25138 | 18:57:19 INFO - TEST-INFO | 25138: exit 0 18:57:19 INFO - TEST-OK | dromaeo_css | took 1113922ms 18:57:19 INFO - TEST-START | kraken 18:57:19 INFO - operating with platform_type : linux_ 18:57:19 INFO - Initialising browser for kraken test... 18:57:19 INFO - TEST-INFO | started process 25475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBdb8z3/profile http://localhost:54572/getInfo.html) 18:57:23 INFO - PID 25475 | __metrics Screen width/height:1600/1200 18:57:23 INFO - PID 25475 | colorDepth:24 18:57:23 INFO - PID 25475 | Browser inner width/height: 1024/695 18:57:23 INFO - PID 25475 | __metrics 18:57:23 INFO - PID 25475 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:57:23 INFO - PID 25475 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:57:24 INFO - TEST-INFO | 25475: exit 0 18:57:24 INFO - Browser initialized. 18:57:24 INFO - Running cycle 1/1 for kraken test... 18:57:24 INFO - TEST-INFO | started process 25571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBdb8z3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:57:36 INFO - PID 25571 | RSS: Main: 144572416 18:57:36 INFO - PID 25571 | 18:57:39 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54572/tests/kraken/driver.html?testName=audio-beat-detection) 18:57:40 INFO - PID 25571 | RSS: Main: 217542656 18:57:40 INFO - PID 25571 | 18:57:42 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54572/tests/kraken/driver.html?testName=audio-dft) 18:57:43 INFO - PID 25571 | RSS: Main: 178089984 18:57:43 INFO - PID 25571 | 18:57:46 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54572/tests/kraken/driver.html?testName=audio-fft) 18:57:46 INFO - PID 25571 | RSS: Main: 258695168 18:57:46 INFO - PID 25571 | 18:57:48 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54572/tests/kraken/driver.html?testName=audio-oscillator) 18:57:49 INFO - PID 25571 | RSS: Main: 170205184 18:57:49 INFO - PID 25571 | 18:57:51 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54572/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:57:51 INFO - PID 25571 | RSS: Main: 173936640 18:57:51 INFO - PID 25571 | 18:57:54 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54572/tests/kraken/driver.html?testName=imaging-darkroom) 18:57:55 INFO - PID 25571 | RSS: Main: 231583744 18:57:55 INFO - PID 25571 | 18:57:58 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54572/tests/kraken/driver.html?testName=imaging-desaturate) 18:57:59 INFO - PID 25571 | RSS: Main: 253411328 18:57:59 INFO - PID 25571 | 18:58:02 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54572/tests/kraken/driver.html?testName=json-parse-financial) 18:58:02 INFO - PID 25571 | RSS: Main: 267198464 18:58:02 INFO - PID 25571 | 18:58:04 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54572/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:58:04 INFO - PID 25571 | RSS: Main: 198217728 18:58:04 INFO - PID 25571 | 18:58:06 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54572/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:58:07 INFO - PID 25571 | RSS: Main: 202194944 18:58:07 INFO - PID 25571 | 18:58:09 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54572/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:58:09 INFO - PID 25571 | RSS: Main: 211968000 18:58:09 INFO - PID 25571 | 18:58:12 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:58:12 INFO - PID 25571 | RSS: Main: 216596480 18:58:12 INFO - PID 25571 | 18:58:15 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:58:16 INFO - PID 25571 | RSS: Main: 216850432 18:58:16 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | Cycle 1(1): loaded http://localhost:54572/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54572/tests/kraken/driver.html?testName=ai-astar) 18:58:18 INFO - PID 25571 | RSS: Main: 266436608 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | __start_tp_report 18:58:18 INFO - PID 25571 | _x_x_mozilla_page_load 18:58:18 INFO - PID 25571 | _x_x_mozilla_page_load_details 18:58:18 INFO - PID 25571 | |i|pagename|runs| 18:58:18 INFO - PID 25571 | |0;ai-astar;108;110;110;108;110;110;109;108;110;109 18:58:18 INFO - PID 25571 | |1;audio-beat-detection;147;116;119;168;117;123;117;116;140;117 18:58:18 INFO - PID 25571 | |2;audio-dft;161;161;163;161;160;161;161;161;159;162 18:58:18 INFO - PID 25571 | |3;audio-fft;73;73;73;105;74;74;75;74;94;74 18:58:18 INFO - PID 25571 | |4;audio-oscillator;84;82;104;82;82;82;96;82;83;113 18:58:18 INFO - PID 25571 | |5;imaging-gaussian-blur;114;114;113;114;113;113;113;113;113;113 18:58:18 INFO - PID 25571 | |6;imaging-darkroom;148;146;146;147;147;146;147;147;147;146 18:58:18 INFO - PID 25571 | |7;imaging-desaturate;94;94;94;94;93;93;93;94;93;95 18:58:18 INFO - PID 25571 | |8;json-parse-financial;47;46;46;46;48;47;47;47;48;47 18:58:18 INFO - PID 25571 | |9;json-stringify-tinderbox;56;55;55;54;55;54;55;54;55;55 18:58:18 INFO - PID 25571 | |10;stanford-crypto-aes;78;78;77;78;86;77;77;77;78;77 18:58:18 INFO - PID 25571 | |11;stanford-crypto-ccm;126;129;134;123;122;121;123;126;217;120 18:58:18 INFO - PID 25571 | |12;stanford-crypto-pbkdf2;179;183;191;191;185;179;182;178;180;177 18:58:18 INFO - PID 25571 | |13;stanford-crypto-sha256-iterative;68;66;67;66;68;64;64;64;67;64 18:58:18 INFO - PID 25571 | __end_tp_report 18:58:18 INFO - PID 25571 | __start_cc_report 18:58:18 INFO - PID 25571 | _x_x_mozilla_cycle_collect,1659 18:58:18 INFO - PID 25571 | __end_cc_report 18:58:18 INFO - PID 25571 | __startTimestamp1494554298319__endTimestamp 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | ------- Summary: start ------- 18:58:18 INFO - PID 25571 | Number of tests: 14 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:0.92 (0.8%) stddev-sans-first:0.87 18:58:18 INFO - PID 25571 | Values: 108.0 110.0 110.0 108.0 110.0 110.0 109.0 108.0 110.0 109.0 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:121.00 stddev:17.83 (14.7%) stddev-sans-first:17.54 18:58:18 INFO - PID 25571 | Values: 147.0 116.0 119.0 168.0 117.0 123.0 117.0 116.0 140.0 117.0 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 18:58:18 INFO - PID 25571 | Values: 161.0 161.0 163.0 161.0 160.0 161.0 161.0 161.0 159.0 162.0 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#3] audio-fft Cycles:10 Average:78.90 Median:74.00 stddev:11.18 (15.1%) stddev-sans-first:11.65 18:58:18 INFO - PID 25571 | Values: 73.0 73.0 73.0 105.0 74.0 74.0 75.0 74.0 94.0 74.0 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:82.00 stddev:11.33 (13.8%) stddev-sans-first:11.88 18:58:18 INFO - PID 25571 | Values: 84.0 82.0 104.0 82.0 82.0 82.0 96.0 82.0 83.0 113.0 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 18:58:18 INFO - PID 25571 | Values: 114.0 114.0 113.0 114.0 113.0 113.0 113.0 113.0 113.0 113.0 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.53 18:58:18 INFO - PID 25571 | Values: 148.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 18:58:18 INFO - PID 25571 | Values: 94.0 94.0 94.0 94.0 93.0 93.0 93.0 94.0 93.0 95.0 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#8] json-parse-financial Cycles:10 Average:46.90 Median:47.00 stddev:0.74 (1.6%) stddev-sans-first:0.78 18:58:18 INFO - PID 25571 | Values: 47.0 46.0 46.0 46.0 48.0 47.0 47.0 47.0 48.0 47.0 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 18:58:18 INFO - PID 25571 | Values: 56.0 55.0 55.0 54.0 55.0 54.0 55.0 54.0 55.0 55.0 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.00 stddev:2.75 (3.5%) stddev-sans-first:2.92 18:58:18 INFO - PID 25571 | Values: 78.0 78.0 77.0 78.0 86.0 77.0 77.0 77.0 78.0 77.0 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#11] stanford-crypto-ccm Cycles:10 Average:134.10 Median:126.00 stddev:29.43 (23.4%) stddev-sans-first:31.06 18:58:18 INFO - PID 25571 | Values: 126.0 129.0 134.0 123.0 122.0 121.0 123.0 126.0 217.0 120.0 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.50 Median:182.50 stddev:5.08 (2.8%) stddev-sans-first:5.23 18:58:18 INFO - PID 25571 | Values: 179.0 183.0 191.0 191.0 185.0 179.0 182.0 178.0 180.0 177.0 18:58:18 INFO - PID 25571 | 18:58:18 INFO - PID 25571 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.50 stddev:1.69 (2.5%) stddev-sans-first:1.59 18:58:18 INFO - PID 25571 | Values: 68.0 66.0 67.0 66.0 68.0 64.0 64.0 64.0 67.0 64.0 18:58:18 INFO - PID 25571 | -------- Summary: end -------- 18:58:18 INFO - PID 25571 | 18:58:19 INFO - TEST-INFO | 25571: exit 0 18:58:19 INFO - TEST-OK | kraken | took 59563ms 18:58:19 INFO - SUITE-END | took 1173s 18:58:19 INFO - Completed test suite (00:19:33) 18:58:19 INFO - javascript benchmark 18:58:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7669.817914227275, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3231.466807976684, 3235.6764323567645, 3251.5285283633875, 3262.820544870031, 3290.720288775454, 5683.488486036256, 5733.369329373765, 5787.0, 5795.710214489269, 5858.648481091138, 5792.536597072235, 5825.679587622679, 5846.356900740915, 5904.143899134623, 5962.8807423851495, 4835.588974937117, 5069.44236134025, 5151.845444636658, 5218.634695571312, 5257.737113144328, 5211.400688920785, 5215.921761173586, 5286.286351342577, 5308.734563271841, 5309.41596424393, 5067.189249720045, 5136.5890728741615, 5138.306328645623, 5145.819896303611, 5150.3047088642925, 5175.223716442526, 5198.896022079537, 5231.450697676765, 5268.972550352682, 5271.604629652753, 5176.611754118456, 5178.922316165261, 5187.0, 5190.506901844356, 5231.0, 5664.716764161775, 5748.827535173909, 5811.215485909391, 5818.709064546756, 5825.679587622679, 6139.124180917356, 6246.968765156145, 6251.593646412968, 6254.155688981975, 6258.374162583751, 6326.367363263683, 6333.366663333676, 6340.175777148941, 6346.428821406095, 6348.301686814447, 5720.1991721159075, 5788.450097240798, 5852.239208902858, 5857.092150716646, 5858.505564387951, 6287.968560157261, 6297.716602752796, 6389.456896163785, 6434.163558737334, 6442.387973142544, 5978.222831031938, 6061.212042434456, 6064.272287325549, 6067.696615169224, 6120.632762034292, 6149.2313460817395, 6162.22972128484, 6182.165407669997, 6200.689965501707, 6230.7819226326865, 6250.874982500324, 6323.051542268697, 6324.399182077787, 6330.39861213184, 6330.968345158245, 6076.240469941257, 6315.621062736251, 6327.3988971047675, 6331.27190373113, 6342.841428964312, 4687.929681054787, 4742.762861856962, 4764.785584648699, 4765.451973023147, 4767.070421267819, 4268.210381079511, 4268.658507319407, 4268.765217913045, 4272.615464608138, 4310.590493903074, 5894.764209431661, 5895.174675545427, 5901.793437229677, 5901.940980590225, 5907.763689452374, 6120.724567394478, 6159.1069294951985, 6223.657698826518, 6289.685515724195, 6291.559590828598, 5847.415258474119, 5914.792982245601, 5918.792842250587, 5930.970345148333, 5967.045272756338, 5501.0, 5506.33923929123, 5506.697131657797, 5506.972465137648, 5508.6970216637665, 6364.077208804697, 6430.64631445275, 6494.870102598016, 6516.6415847128865, 6627.900581491282, 6308.716107775253, 6338.683065846597, 6340.397662222082, 6347.68261586928, 6354.777582784581, 6524.314946930694, 6577.704003319766, 6602.306757790363, 6608.372204640552, 6611.404973552403, 6086.178365920544, 6107.755689772359, 6128.816135515942, 6233.0, 6236.563440559117, 6286.497080233479, 6287.654179020198, 6327.778527751507, 6336.873262534816, 6339.556231063966, 6147.600405973598, 6149.169862068742, 6150.7847225346895, 6154.846128846814, 6158.291796443466, 5998.970005149947, 6016.669083200466, 6072.089186622042, 6091.177691011657, 6148.292946311052, 6095.136089334496, 6095.691643723386, 6107.450329470191, 6124.8775024500155, 6131.4481696645735, 6121.265448146251, 6126.426068710427, 6130.356312587114, 6136.6011209271255, 6137.478314343331, 5903.822885313448, 5940.46535811779, 5952.642841429355, 5954.10688396744, 5956.434138756811], "value": 5738.608347777098, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.6813854112002, 814.1654803826078, 836.5399030533205, 1126.7633796902655, 1133.648568943628, 29298.85350573247, 29793.255168620795, 33345.99999999997, 33959.490607640844, 34088.31823363531, 35965.0, 36316.81841590788, 36339.27321453576, 36341.27317453656, 36360.63639363612, 5569.832905012856, 6979.057827193315, 7104.786856394317, 7109.573425594455, 7112.573245605255, 5660.745266463019, 7057.576545407292, 7180.425565954737, 7188.353048225658, 7188.676509557056, 7276.272372762734, 7290.198078211392, 7296.452766042542, 7308.415326773846, 7310.707571697152, 5553.8333849984565, 7200.207977122539, 7271.454640901953, 7275.454340924452, 7281.927180728205, 5642.971785141048, 7017.649117544102, 7084.0, 7090.432765378758, 7091.290870912868, 35697.0, 36001.279974400364, 36005.45991810125, 36021.279574408625, 36086.458703119475, 3474.7567670263093, 3506.0533655913014, 3517.103138699641, 3520.647935206459, 3523.4186359250693, 28392.432151357065, 28493.715062849522, 28548.0, 28574.0, 28613.427731445463, 3722.1066943933533, 3765.152840610868, 3768.773873567567, 3791.052236940765, 3827.942580861289, 194873.0, 195430.0, 196686.01656991767, 197025.0, 197267.0, 47467.28799068017, 47576.145431274235, 47666.285005724945, 47722.0, 47741.0, 48711.75644121828, 48955.776105597644, 49179.75410122998, 49181.50818491769, 49277.507224928006, 14554.563363099123, 14670.413183472541, 14695.11829290246, 14695.853041469662, 14699.338529766186, 10559.736006599896, 10704.839427408595, 11890.28658280506, 11938.0, 12003.219790713576, 11273.154513411528, 11362.375069371099, 14625.853741462663, 14707.92646036763, 14890.553283401516, 5741.655500669973, 5752.36723960364, 5807.332156802022, 5813.6221145625395, 5863.120531920246, 1054.8839627640953, 1095.2771171027084, 1095.4905968724422, 1108.0747575774158, 1110.4947249001684, 26436.517376137923, 26652.866735666197, 26934.0, 26966.595501067106, 27013.324666883484, 1183.2841131115551, 1192.8568571771443, 1193.4569770754285, 1214.9149559530924, 1228.619128070301, 13371.799423008662, 13653.931730341284, 13679.452821887213, 13748.93125534386, 13834.65413364674, 249107.0, 249991.0, 252316.0, 252347.0, 253401.0, 51703.43486455018, 51836.22245666243, 51988.48011519836, 52028.21957670638, 52055.0, 1435.2751860310477, 1498.685276092011, 1515.636247300662, 1515.7423238049557, 1527.2058529564565, 23556.764432355456, 24765.504689906462, 25001.999920002996, 25028.749712502642, 29686.0, 49182.26226606532, 49631.25553116634, 49646.50353496419, 49678.751606241734, 49715.25427118524, 216416.0, 217423.0, 218794.0, 219147.0, 219711.0, 34709.140720298674, 34769.0, 35158.29683406369, 35255.471167933014, 35264.647353527165, 41350.1729965405, 43477.13045739131, 43505.51955843588, 43601.0, 43657.781711091244, 30609.54085688761, 30737.846310769197, 32063.190521421973, 32537.674623253464, 32665.18337041593, 31352.0, 31675.366492670477, 32421.18947026343, 32484.18789530186, 33092.669073308956, 37328.62671373251, 37479.81260093682, 37488.437673434375, 37508.43737343887, 37512.249755005294, 29696.703032970257, 30551.847240763655, 30728.385432291678, 30928.53607195939, 31238.375232494767, 24326.51346973086, 25538.361540961625, 25840.741592584585, 26098.217053488424, 26188.476230474902], "value": 16916.201950361992, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.2081593142024, 451.28246088718953, 461.4485689600926, 462.56056746091224, 474.5610310462822, 18677.346292879716, 18682.252709891603, 19100.522486937833, 19136.521586960316, 19177.904110479445, 20542.486437839063, 21247.57504849902, 21430.785692143072, 21562.353129406103, 21757.564848703016, 5417.810376636819, 5626.493615574597, 5628.577856660746, 5632.098864181732, 5637.3517045539675, 5344.064788661988, 5518.33779946405, 5548.334199895998, 5551.72241387931, 5553.389127196006, 5334.066538355792, 5490.478404551562, 5490.670559766427, 5521.033819081665, 5524.889502209953, 5446.556662484445, 5473.67157970523, 5513.145462453286, 5534.280543529356, 5535.142052981774, 4934.062528119646, 5002.049610573979, 5002.1496345621335, 5006.274090256892, 5042.520960508746, 25324.746752532425, 25768.613470797955, 25886.093986710373, 25899.611505827426, 26255.606165907528, 2045.4886278430392, 2098.6642137257963, 2107.557412943284, 2129.127057906251, 2140.9571808563896, 16651.91674041622, 16877.32490700383, 17004.0, 17118.058506782123, 17122.40071597488, 2131.531063166101, 2159.88120653364, 2204.691343211952, 2212.6017316882953, 2242.0583354990945, 110146.44926775395, 110793.10551438962, 115600.42199789031, 117798.41100794527, 121107.9064048028, 11434.371109588887, 12452.875471245172, 12552.246865188117, 12611.747765044647, 12823.294718790556, 17394.652106958045, 17621.383251586132, 17689.46931592054, 17755.289788408318, 17866.374676886247, 8812.911870881337, 8920.375573709778, 8935.865962010575, 8949.910500894908, 9198.080191980882, 8284.0, 8404.915950840414, 8514.57427128641, 8553.486790792573, 8594.87107693385, 7858.410619203582, 7886.684532618746, 8067.515949043076, 8093.392995525359, 8128.431009829374, 2222.655488399301, 2247.763984781607, 2254.5490901819376, 2268.88655567221, 2358.3750306168877, 1018.3024628129607, 1030.5414090729703, 1048.1038711901215, 1048.99475502622, 1058.3226734889677, 18615.126650725786, 19991.40025799228, 20027.399178024683, 20116.29592964239, 20177.092030858646, 1056.5140035583718, 1057.2070946789909, 1059.1103473082649, 1071.973200669974, 1076.8869268726671, 10520.998415213886, 10895.509702063426, 10906.672799816019, 10925.945370273097, 10945.890541094486, 446916.0, 447247.0, 448164.0, 468519.0, 473211.0, 92913.53543232376, 95355.0, 96708.0, 97308.0, 98058.0, 1184.8163534652142, 1196.9940150299367, 1235.950561977511, 1236.5548402575066, 1250.6998320403038, 16285.104319262555, 16692.916535417244, 16757.1621418931, 16852.747208791632, 16965.0, 43670.344944825214, 44605.77697111494, 44941.0, 45743.77128114338, 46815.53184468248, 56414.0, 57698.711506442196, 58735.0, 59033.70483147557, 59223.703881480316, 9204.95397523008, 9260.444373337621, 9260.814783704154, 9329.766755831159, 9683.612655493702, 14718.926405367905, 14880.577467182826, 14982.550523484313, 15094.54716358511, 15414.614634634223, 12669.0, 12799.0, 12819.615411537668, 12921.289329086614, 13143.73712525725, 11506.884931150917, 12377.938110309751, 12710.618681439571, 12988.415521301375, 13092.672683182996, 13185.0, 13294.933525332312, 13368.197908125543, 13442.260675662541, 13547.390367433292, 9238.30712696537, 9289.489078100769, 9366.859497107413, 9482.620695172116, 9565.665201717906, 12072.154949153475, 12123.211991220542, 12669.873301266869, 12822.487100516248, 13133.212007279593], "value": 10045.220688297852, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1347.4138749643905, 1389.7290028444452, 1407.0572716280092, 1415.4055296775352, 1417.6455886028493, 11475.139364547662, 11907.0, 11926.344051077198, 11930.76138477232, 11931.880681193195, 11621.12841536884, 11715.882841171586, 11863.7627247455, 11945.940270298657, 11948.462319195636, 2423.951520969584, 2460.778529932306, 2464.544059349017, 2465.802735781142, 2469.4320306329555, 1969.6257711034857, 2357.5520651076326, 2391.8445301055376, 2406.0, 2412.6984126984125, 2073.243266207831, 2323.732770731362, 2428.514297140579, 2446.571849926265, 2446.963295550568, 2373.4066483379156, 2384.0582969726947, 2394.1022116706235, 2395.3532546212514, 2397.44858682504, 2303.4356582637192, 2365.47959448921, 2367.3963139399343, 2368.218487898989, 2368.8984622150783, 11502.079833613374, 11594.304341739438, 11595.188336816425, 11603.245789023686, 11606.477708503138, 6420.357964203589, 6628.767993120217, 6630.104935833649, 6633.4693224541925, 6640.33596640337, 3705.7035437164964, 3889.5138107736534, 4108.568600296986, 4111.876643700693, 4143.854965076208, 1423.6939058102557, 1427.807246021784, 1464.1068947941747, 1515.2272341106004, 1528.5032364481588, 17802.198901049484, 17944.282228710836, 17958.910205449152, 17988.55028624282, 17999.19003644826, 5121.8719532011255, 5184.338125508703, 5371.865703357447, 5422.91865622016, 5471.37079235893, 12600.747985040249, 12632.0, 12683.556075537497, 12692.555760548337, 12695.492180312684, 6505.837354066186, 6511.15355003856, 6512.088307636935, 6513.511486638521, 6515.967420162869, 5961.612495187799, 6144.754209831646, 6205.875882482325, 6281.8743625127245, 6283.7800676976085, 4171.498260626172, 4292.205941900758, 4347.413099231627, 4387.934180987288, 4460.955390446119, 1049.8477720730452, 1119.3563700871869, 1141.1042331769522, 1151.1308961733837, 1153.7366583590954, 655.6361219523116, 805.7341077444429, 839.2866063845682, 848.4993853626266, 884.7964968057254, 5997.850053748692, 6217.782377616762, 6251.6561589112125, 6333.588316759396, 6372.490200783926, 971.1550950672819, 973.4694591447678, 982.4989255479613, 990.7968866382374, 1009.535613617744, 3841.366174581163, 3893.182431689377, 3927.5286965564314, 3973.920521589552, 3985.501812273466, 15333.616659583377, 15884.444044458389, 15905.602359940862, 15999.440019599258, 16013.279402426919, 15013.099214047192, 15576.221188940508, 15675.686486270211, 15693.45072922465, 15714.842851571566, 9215.308851836138, 9443.480608566595, 9448.433094014381, 9448.763780905532, 9460.2904782143, 6696.665166741741, 7257.745978890714, 7263.4915555910575, 7312.15910170316, 7431.925680743123, 13301.866981330062, 13469.663258418617, 13977.58067257984, 13990.930045349709, 14010.43958241659, 13749.450021999008, 13852.307384630929, 13983.230922299372, 14086.859131408555, 14254.786178207543, 9257.953710231406, 9411.576479058322, 9428.528573571431, 9434.528273586431, 9440.244780417413, 11288.604898828502, 11651.766964660828, 11753.529858805552, 11763.705907352385, 11783.941080294544, 9306.208972237435, 9374.765630859283, 9504.809903801746, 9565.139137477661, 9832.262580306362, 9131.863022054808, 9215.0, 9326.393784403992, 9401.0, 9586.568604412678, 8493.0, 8642.265407440438, 8664.176903194186, 8688.0, 8688.52213128284, 5903.793367232126, 5939.881202376015, 5947.553933454921, 6008.669523176267, 6105.877882442415, 6032.75868965254, 6091.9086213707715, 6149.692515374303, 6157.107219453064, 6163.84590385244], "value": 5436.502913034047, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.9243943650708, 406.4269380173955, 428.45158197507203, 430.47267097805195, 434.20757118259183, 5612.7754889804355, 5756.395578464264, 5864.589478736485, 5903.2916050074, 5909.645421274727, 5618.999090809183, 5773.162891380747, 5788.6816225107605, 5795.420457954203, 5805.883882322361, 4613.561711637398, 4626.560476754703, 4647.86056418308, 4648.953510464903, 4671.159191345557, 4293.892652683677, 4594.47163576188, 4650.441946966369, 4651.790669419867, 4664.787155339619, 4586.325991013273, 4590.472095709003, 4591.47198072221, 4592.977035114836, 4604.125216208927, 4594.517575654559, 4602.355670206174, 4608.74651894144, 4609.03210325832, 4621.884452888705, 4150.667946564267, 4170.91658166838, 4173.4157217989505, 4180.163967206571, 4184.330507118846, 5647.661140331593, 5660.971695141539, 5665.66006039639, 5677.659340439587, 5696.886062278772, 5385.461453854622, 5448.318960129984, 5470.316210473691, 5489.39616642169, 5491.148871924858, 6206.224221972254, 6216.222972128484, 6228.941080016408, 6248.125262463259, 6269.216347956505, 4718.764061796896, 4728.905421891577, 4732.455767586703, 4733.857984260478, 4733.9763301183275, 6199.566030377875, 6332.176817013758, 6366.236051673783, 6387.552871299057, 6399.392057754506, 4852.126617208936, 4866.343043689057, 4874.2201247800895, 4883.780229889663, 4889.731064791399, 4942.654014218971, 4952.925706114411, 4953.405591328991, 4953.925691114636, 4967.726775027409, 4964.801407943714, 5161.303224064778, 5208.244804503402, 5211.635185536976, 5450.127979523258, 5889.146073819272, 6204.937950620436, 6207.34822843604, 6211.65835879031, 6218.160548326008, 1490.8658220760183, 1504.9322780474904, 1541.4758981946193, 1551.5655616427418, 1555.175756848872, 1023.8310678737924, 1031.896810318962, 1044.3159730376615, 1058.402002868377, 1067.8505009298703, 5808.273965754281, 5848.5321174305955, 5856.209411729362, 5879.647221166658, 5892.381299963442, 6285.96857015712, 6299.7085597452415, 6313.779017734358, 6315.368463153648, 6349.777757778548, 5725.198472213893, 5822.656977089539, 5829.8251052468495, 5875.6474611523445, 5896.457330109683, 3306.6528014558608, 3325.2518183409024, 3362.176266814646, 3364.61306949699, 3372.5278461015478, 6359.569096953241, 6557.786809440268, 6607.017894631687, 6610.8016759497295, 6629.734810607618, 6492.577982431221, 6521.64130972801, 6522.0, 6528.412442880163, 6548.8362790930605, 6379.202599675041, 6585.934140658532, 6613.603183808987, 6623.503237257225, 6643.734250630017, 6355.332690067661, 6359.682015899279, 6359.90460143089, 6394.848927192964, 6403.2316122063785, 6059.848503787441, 6294.968525157345, 6328.46208072319, 6335.714892829741, 6335.904961425675, 6608.240052394036, 6645.501587381063, 6646.867062658816, 6657.3342665733035, 6664.833379165366, 4445.955540444684, 4463.888402789957, 4473.776311184492, 4474.306482495218, 4478.104379124123, 6067.726952287246, 6204.100405441276, 6240.656763878031, 6369.777057802955, 6376.449420231945, 5983.790567330123, 6129.724162412791, 6140.017597184429, 6152.384761523812, 6153.753849845956, 6055.515558755377, 6140.815775526741, 6145.985912324595, 6153.753909802223, 6189.288231853395, 6099.3290738017895, 6114.205153330038, 6137.877242455215, 6144.354842741448, 6146.723397447036, 6168.444839964424, 6169.6683790752495, 6193.721282542387, 6200.286966998672, 6202.937970620236, 5802.0, 5952.73212705438, 5994.880102398015, 5996.37038110992, 6034.668093254913], "value": 4755.256652281111, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [803.0443771911421, 814.9470284431508, 815.5310696349601, 874.3835595904885, 888.1961824548781, 16706.916465417686, 17372.0, 17674.734878976826, 17689.203985820637, 17707.291708331682, 16841.83158168418, 17034.23345949432, 17205.91397043013, 17207.13964301786, 17232.913835430805, 984.4339504784724, 1000.4297550396277, 1003.6537394598888, 1010.4644538394663, 1011.2163073617932, 1029.0327092533032, 1029.3772267778, 1029.5367084811865, 1030.361176070837, 1034.5344594932274, 1013.944233067181, 1047.9109275711573, 1048.0, 1050.6480329089763, 1052.5789684126335, 1015.8831734350533, 1051.7107795356262, 1053.936763794171, 1054.7943151085542, 1055.2033214922685, 741.3994664321916, 760.9695612175507, 769.0310209136528, 769.9807504812369, 770.791886190731, 15605.297761600641, 15715.371385144696, 15899.523014309589, 15941.601459963478, 16036.0, 17140.228689708994, 17228.195222265425, 17811.821881781147, 18107.094645267814, 18116.63766724658, 14758.926205369013, 15064.246787660682, 15101.3204405802, 15119.09285442866, 15216.543503694907, 3547.4324108142832, 3564.3049605326714, 3569.0720412692885, 3570.5715314162467, 3573.4818451324672, 82504.0, 82699.0, 83469.16530834675, 84333.57833210856, 84471.15528844694, 14990.250487475583, 15218.391264349524, 15376.61558461025, 15384.538463846102, 15469.0, 25980.22059338223, 26758.0, 27786.0, 27791.16626501208, 27835.02577409781, 8006.639701213459, 8237.382196335298, 8238.8352232955, 8250.669973201126, 8265.429568381987, 4016.9397459038137, 4054.8580799671868, 4075.2053349596545, 4102.138550904284, 4117.75293482392, 4248.808803603845, 4402.537733537996, 4405.647548196137, 4409.096135292258, 4415.315626077963, 864.9048604653483, 867.9218870301577, 868.7871471489399, 870.3211495033884, 880.0231742765525, 647.2136354329513, 647.2330288608015, 655.3872129558878, 659.152988409891, 666.7866282789557, 11288.435578221057, 11515.712107197387, 11534.769304613861, 11638.1271404645, 12393.938030309972, 692.7817737412698, 702.3608516250188, 710.0, 714.1501613080418, 720.1538192623751, 5525.557955363562, 5548.834744703577, 5578.9163162552595, 5770.6249093808765, 5932.79235226765, 78201.21798782054, 78467.60766196133, 79285.60357198177, 81967.0, 84522.0, 70923.2907670927, 71486.28513714796, 72606.27393726101, 74769.6261518689, 75066.62466687632, 42854.785891058295, 47597.28604070942, 47827.52172478231, 59499.405005950255, 61560.38439615636, 12372.690682733004, 13280.0, 13335.733285334432, 13353.66615834612, 13416.262105584286, 33550.66449335475, 33735.15662108467, 34041.0, 34147.65852341544, 35310.47034294436, 39934.80032599935, 40500.79749601233, 40547.59452405438, 40860.38709419421, 41748.58251417569, 14807.851921480647, 14843.92578037103, 14931.701365972402, 15064.698706026038, 15117.697646046798, 16738.748918765985, 17476.475705728848, 17479.47561573155, 17498.91250543739, 17599.472015839547, 16230.837691622932, 16701.749473758147, 16785.748213777046, 16832.57918552046, 16930.068846213577, 15897.52307430779, 16128.193590320672, 16178.919105404868, 16427.0, 16495.422660206834, 15781.21093945321, 15836.841631583997, 15854.207289635702, 16128.67742645164, 16366.018038917702, 11517.366544840113, 11858.76282474363, 11924.165308428674, 11994.160408771302, 12186.695332616755, 13394.263315517741, 13787.103838250883, 13812.309384530934, 13817.101888377223, 13932.373043213283], "value": 8074.543339238376, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1482.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 110.0, 108.0, 110.0, 110.0, 109.0, 108.0, 110.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 119.0, 168.0, 117.0, 123.0, 117.0, 116.0, 140.0, 117.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 161.0, 160.0, 161.0, 161.0, 161.0, 159.0, 162.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 105.0, 74.0, 74.0, 75.0, 74.0, 94.0, 74.0], "value": 78.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 104.0, 82.0, 82.0, 82.0, 96.0, 82.0, 83.0, 113.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 93.0, 94.0, 93.0, 95.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 46.0, 46.0, 46.0, 48.0, 47.0, 47.0, 47.0, 48.0, 47.0], "value": 46.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 54.0, 55.0, 54.0, 55.0, 54.0, 55.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 78.0, 86.0, 77.0, 77.0, 77.0, 78.0, 77.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 129.0, 134.0, 123.0, 122.0, 121.0, 123.0, 126.0, 217.0, 120.0], "value": 134.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 183.0, 191.0, 191.0, 185.0, 179.0, 182.0, 178.0, 180.0, 177.0], "value": 182.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 66.0, 68.0, 64.0, 64.0, 64.0, 67.0, 64.0], "value": 65.8, "unit": "score"}]}]} 18:58:19 INFO - Return code: 0 18:58:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:58:19 INFO - # TBPL SUCCESS # 18:58:19 INFO - Running post-action listener: _resource_record_post_action 18:58:19 INFO - [mozharness: 2017-05-12 01:58:19.647816Z] Finished run-tests step (success) 18:58:19 INFO - Running post-run listener: _resource_record_post_run 18:58:19 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 16384; Write bytes: 396828672; Read time: 172; Write time: 222744 18:58:19 INFO - TinderboxPrint: CPU usage
12.9% 18:58:19 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 172 18:58:19 INFO - TinderboxPrint: I/O write bytes / time
396,828,672 / 222,744 18:58:19 INFO - TinderboxPrint: CPU idle
8,281.0 (87.1%) 18:58:19 INFO - TinderboxPrint: CPU user
1,183.0 (12.4%) 18:58:19 INFO - TinderboxPrint: Swap in / out
0 / 0 18:58:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 125071360; Read time: 60; Write time: 93172 18:58:19 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 271196160; Read time: 100; Write time: 129536 18:58:20 INFO - Running post-run listener: _upload_blobber_files 18:58:20 INFO - Blob upload gear active. 18:58:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:58:20 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:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:58:20 INFO - (blobuploader) - INFO - Open directory for files ... 18:58:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:58:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:58:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:23 INFO - (blobuploader) - INFO - Done attempting. 18:58:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:58:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:58:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:24 INFO - (blobuploader) - INFO - Done attempting. 18:58:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:58:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:58:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:25 INFO - (blobuploader) - INFO - Done attempting. 18:58:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:58:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:58:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:58:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:58:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:58:26 INFO - (blobuploader) - INFO - Done attempting. 18:58:26 INFO - (blobuploader) - INFO - Iteration through files over. 18:58:26 INFO - Return code: 0 18:58:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:58:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:58:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/681b29f802b40c012cf83a6cb1918170418831dfd8dbe186666f4e1d04e307c30645eb1ccda51bbbfcac1e35b33616b4a232f3cace9536bcd57b64d305f5ad87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/192bd7ab3b11769d0f38267aff8f940252295228db8f277f7ffe8750e304d6715e209bde3a21551c2817539c04db223abf3185345613f6225936ea0a73869ded", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c247eab85bfd22bb279f65356511d825b615454fd3b654be12e3a2030ee5838d62cf301d02296c646494f571a83a010e9eba8ae95a4767fa01238f9457912215", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42b399c671a21bfa5f78a528fc530ad9bd9bfd4636e7f40f789d52d49c08ad27b120b8e62ac252d8201d408693d1bb019871e20b654fa100d1caa98413c582f3"} 18:58:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:58:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:58:26 INFO - Contents: 18:58:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/681b29f802b40c012cf83a6cb1918170418831dfd8dbe186666f4e1d04e307c30645eb1ccda51bbbfcac1e35b33616b4a232f3cace9536bcd57b64d305f5ad87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/192bd7ab3b11769d0f38267aff8f940252295228db8f277f7ffe8750e304d6715e209bde3a21551c2817539c04db223abf3185345613f6225936ea0a73869ded", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c247eab85bfd22bb279f65356511d825b615454fd3b654be12e3a2030ee5838d62cf301d02296c646494f571a83a010e9eba8ae95a4767fa01238f9457912215", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42b399c671a21bfa5f78a528fc530ad9bd9bfd4636e7f40f789d52d49c08ad27b120b8e62ac252d8201d408693d1bb019871e20b654fa100d1caa98413c582f3"} 18:58:26 INFO - Running post-run listener: copy_logs_to_upload_dir 18:58:26 INFO - Copying logs to upload dir... 18:58:26 INFO - mkdir: /builds/slave/test/build/upload/logs 18:58:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.486858 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-05-11 18:58:26.705067) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 18:58:26.708861) ========= 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=438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/681b29f802b40c012cf83a6cb1918170418831dfd8dbe186666f4e1d04e307c30645eb1ccda51bbbfcac1e35b33616b4a232f3cace9536bcd57b64d305f5ad87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/192bd7ab3b11769d0f38267aff8f940252295228db8f277f7ffe8750e304d6715e209bde3a21551c2817539c04db223abf3185345613f6225936ea0a73869ded", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c247eab85bfd22bb279f65356511d825b615454fd3b654be12e3a2030ee5838d62cf301d02296c646494f571a83a010e9eba8ae95a4767fa01238f9457912215", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42b399c671a21bfa5f78a528fc530ad9bd9bfd4636e7f40f789d52d49c08ad27b120b8e62ac252d8201d408693d1bb019871e20b654fa100d1caa98413c582f3"} build_url:https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/681b29f802b40c012cf83a6cb1918170418831dfd8dbe186666f4e1d04e307c30645eb1ccda51bbbfcac1e35b33616b4a232f3cace9536bcd57b64d305f5ad87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/192bd7ab3b11769d0f38267aff8f940252295228db8f277f7ffe8750e304d6715e209bde3a21551c2817539c04db223abf3185345613f6225936ea0a73869ded", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c247eab85bfd22bb279f65356511d825b615454fd3b654be12e3a2030ee5838d62cf301d02296c646494f571a83a010e9eba8ae95a4767fa01238f9457912215", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42b399c671a21bfa5f78a528fc530ad9bd9bfd4636e7f40f789d52d49c08ad27b120b8e62ac252d8201d408693d1bb019871e20b654fa100d1caa98413c582f3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 18:58:26.735491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:58:26.736056) ========= 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=438111f3d31ce799eff2119d000001bc-1494553060.175352-555360043 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:58:26.819654) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 18:58:26.819979) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 18:58:26.820288) ========= ========= Total master_lag: 0.16 =========