builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1494596080.78 results: success (0) revision: bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:34:40.784719) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:34:40.785151) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:34:40.785433) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:34:40.810414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:34:40.810686) ========= 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=fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 06:34:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.7M=0.001s 2017-05-12 06:34:41 (19.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.178646 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:34:41.022315) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:34:41.025675) ========= 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=fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013488 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:34:41.075019) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 06:34:41.075327) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 --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 bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 --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=fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 06:34:41,132 truncating revision to first 12 chars 2017-05-12 06:34:41,132 Setting DEBUG logging. 2017-05-12 06:34:41,132 attempt 1/10 2017-05-12 06:34:41,132 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bcb5e1ff13f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 06:34:42,327 unpacking tar archive at: mozilla-central-bcb5e1ff13f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.520509 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 06:34:42.611919) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:34:42.612265) ========= script_repo_revision: bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:34:42.615648) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:34:42.615920) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:34:42.625960) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-05-12 06:34:42.626294) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:34:42 INFO - MultiFileLogger online at 20170512 06:34:42 in /builds/slave/test 06:34:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:34:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:34:42 INFO - {'append_to_log': False, 06:34:42 INFO - 'base_work_dir': '/builds/slave/test', 06:34:42 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:34:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:34:42 INFO - 'branch': 'Firefox-Non-PGO', 06:34:42 INFO - 'buildbot_json_path': 'buildprops.json', 06:34:42 INFO - 'config_files': ('talos/linux_config.py',), 06:34:42 INFO - 'default_actions': ('clobber', 06:34:42 INFO - 'read-buildbot-config', 06:34:42 INFO - 'download-and-extract', 06:34:42 INFO - 'populate-webroot', 06:34:42 INFO - 'create-virtualenv', 06:34:42 INFO - 'install', 06:34:42 INFO - 'run-tests'), 06:34:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:34:42 INFO - 'download_minidump_stackwalk': True, 06:34:42 INFO - 'download_symbols': 'ondemand', 06:34:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:34:42 INFO - 'tooltool.py': '/tools/tooltool.py', 06:34:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:34:42 INFO - '/tools/misc-python/virtualenv.py')}, 06:34:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:34:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:34:42 INFO - 'gecko_profile': False, 06:34:42 INFO - 'gecko_profile_interval': 0, 06:34:42 INFO - 'installer_path': 'installer.exe', 06:34:42 INFO - 'log_level': 'info', 06:34:42 INFO - 'log_name': 'talos', 06:34:42 INFO - 'log_to_console': True, 06:34:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:34:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:34:42 INFO - 'opt_config_files': (), 06:34:42 INFO - 'pip_index': False, 06:34:42 INFO - 'suite': 'dromaeojs', 06:34:42 INFO - 'system_bits': '32', 06:34:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:34:42 INFO - 'title': 'talos-linux64-ix-048', 06:34:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:34:42 INFO - 'use_talos_json': True, 06:34:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:34:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:34:42 INFO - 'work_dir': 'build'} 06:34:42 INFO - [mozharness: 2017-05-12 13:34:42.889569Z] Running clobber step. 06:34:42 INFO - Running pre-action listener: _resource_record_pre_action 06:34:42 INFO - Running main action method: clobber 06:34:42 INFO - rmtree: /builds/slave/test/build 06:34:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:34:43 INFO - Running post-action listener: _resource_record_post_action 06:34:43 INFO - [mozharness: 2017-05-12 13:34:43.858211Z] Finished clobber step (success) 06:34:43 INFO - [mozharness: 2017-05-12 13:34:43.858311Z] Running read-buildbot-config step. 06:34:43 INFO - Running pre-action listener: _resource_record_pre_action 06:34:43 INFO - Running main action method: read_buildbot_config 06:34:43 INFO - Using buildbot properties: 06:34:43 INFO - { 06:34:43 INFO - "project": "", 06:34:43 INFO - "product": "firefox", 06:34:43 INFO - "who": "cbook@mozilla.com", 06:34:43 INFO - "installer_path": "public/build/target.tar.bz2", 06:34:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:34:43 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:34:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:34:43 INFO - "stage_platform": "linux64", 06:34:43 INFO - "basedir": "/builds/slave/test", 06:34:43 INFO - "buildnumber": 596, 06:34:43 INFO - "platform": "ubuntu64_hw", 06:34:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:34:43 INFO - "slavebuilddir": "test", 06:34:43 INFO - "taskId": "O-GNouHTR-Kud1GnQy99Kg", 06:34:43 INFO - "branch": "mozilla-central", 06:34:43 INFO - "script_repo_revision": "production", 06:34:43 INFO - "revision": "bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501", 06:34:43 INFO - "slavename": "talos-linux64-ix-048", 06:34:43 INFO - "repo_path": "mozilla-central" 06:34:43 INFO - } 06:34:43 INFO - Finding installer, test and symbols from parent task. 06:34:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O-GNouHTR-Kud1GnQy99Kg'}, attempt #1 06:34:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O-GNouHTR-Kud1GnQy99Kg'}, attempt #1 06:34:44 INFO - Task dependencies: VoXTNIBARVCpnHEkjQyyzw 06:34:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw'}, attempt #1 06:34:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.tar.bz2 06:34:45 INFO - Set test_url: https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/test_packages.json 06:34:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.crashreporter-symbols.zip 06:34:45 INFO - Running post-action listener: _resource_record_post_action 06:34:45 INFO - [mozharness: 2017-05-12 13:34:45.291346Z] Finished read-buildbot-config step (success) 06:34:45 INFO - [mozharness: 2017-05-12 13:34:45.291565Z] Running download-and-extract step. 06:34:45 INFO - Running pre-action listener: _resource_record_pre_action 06:34:45 INFO - Running main action method: download_and_extract 06:34:45 INFO - mkdir: /builds/slave/test/build/tests 06:34: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')]} 06:34:45 INFO - trying https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.test_packages.json 06:34:45 INFO - Downloading https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:34:45 INFO - Downloaded 986 bytes. 06:34:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:34:45 INFO - Using the following test package requirements: 06:34:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:34:45 INFO - u'common': [u'target.common.tests.zip'], 06:34:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:34:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:34:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:34:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:34:45 INFO - u'mozbase': [u'target.common.tests.zip'], 06:34:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:34:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:34:45 INFO - u'web-platform': [u'target.common.tests.zip', 06:34:45 INFO - u'target.web-platform.tests.zip'], 06:34:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:34:45 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:34:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.common.tests.zip 06:34:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:34:45 INFO - Fetch https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.common.tests.zip into memory 06:34:47 INFO - Content-Length response header: 58591109 06:34:47 INFO - Bytes received: 58591109 06:34:57 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:34:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.common.tests.zip 06:34:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:34:57 INFO - Fetch https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.common.tests.zip into memory 06:34:58 INFO - Content-Length response header: 58591109 06:34:58 INFO - Bytes received: 58591109 06:35:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.talos.tests.zip 06:35:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:35:09 INFO - Fetch https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.talos.tests.zip into memory 06:35:10 INFO - Content-Length response header: 14409411 06:35:10 INFO - Bytes received: 14409411 06:35:10 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')]} 06:35:10 INFO - trying https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.tar.bz2 06:35:10 INFO - Downloading https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:35:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:35:11 INFO - Downloaded 63499601 bytes. 06:35:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.tar.bz2 06:35:11 INFO - mkdir: /builds/slave/test/properties 06:35:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:35:11 INFO - Writing to file /builds/slave/test/properties/build_url 06:35:11 INFO - Contents: 06:35:11 INFO - build_url:https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.tar.bz2 06:35:11 INFO - Running post-action listener: _resource_record_post_action 06:35:11 INFO - Running post-action listener: set_extra_try_arguments 06:35:11 INFO - [mozharness: 2017-05-12 13:35:11.634678Z] Finished download-and-extract step (success) 06:35:11 INFO - [mozharness: 2017-05-12 13:35:11.634775Z] Running populate-webroot step. 06:35:11 INFO - Running pre-action listener: _resource_record_pre_action 06:35:11 INFO - Running main action method: populate_webroot 06:35:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:35:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:35:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:35:11 INFO - '--tppagecycles', 06:35:11 INFO - '7'], 06:35:11 INFO - 'tests': ['tsvgm']}}, 06:35:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:35:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:35:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:35:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:35:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:35:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:35:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:35:11 INFO - 'talos_options': ['--disable-e10s'], 06:35:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:35:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:35:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:35:11 INFO - 'talos_options': ['--disable-e10s'], 06:35:11 INFO - 'tests': ['damp', 'tps']}, 06:35:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:35:11 INFO - 'tests': ['damp', 'tps']}, 06:35:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:35:11 INFO - 'tests': ['dromaeo_dom']}, 06:35:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:35:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:35:11 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:35:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:35:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:35:11 INFO - 'tests': ['a11yr', 06:35:11 INFO - 'ts_paint', 06:35:11 INFO - 'tpaint', 06:35:11 INFO - 'sessionrestore', 06:35:11 INFO - 'sessionrestore_no_auto_restore', 06:35:11 INFO - 'tabpaint']}, 06:35:11 INFO - 'other-e10s': {'tests': ['a11yr', 06:35:11 INFO - 'ts_paint', 06:35:11 INFO - 'tpaint', 06:35:11 INFO - 'sessionrestore', 06:35:11 INFO - 'sessionrestore_no_auto_restore', 06:35:11 INFO - 'tabpaint']}, 06:35:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:35:11 INFO - 'ts_paint', 06:35:11 INFO - 'tpaint', 06:35:11 INFO - 'sessionrestore', 06:35:11 INFO - 'sessionrestore_no_auto_restore', 06:35:11 INFO - 'tabpaint']}, 06:35:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:35:11 INFO - 'ts_paint', 06:35:11 INFO - 'tpaint', 06:35:11 INFO - 'sessionrestore', 06:35:11 INFO - 'sessionrestore_no_auto_restore', 06:35:11 INFO - 'tabpaint']}, 06:35:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:35:11 INFO - 'tests': ['a11yr', 06:35:11 INFO - 'ts_paint', 06:35:11 INFO - 'tpaint', 06:35:11 INFO - 'sessionrestore', 06:35:11 INFO - 'sessionrestore_no_auto_restore', 06:35:11 INFO - 'tabpaint']}, 06:35:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:35:11 INFO - 'tests': ['a11yr', 06:35:11 INFO - 'ts_paint', 06:35:11 INFO - 'tpaint', 06:35:11 INFO - 'sessionrestore', 06:35:11 INFO - 'sessionrestore_no_auto_restore', 06:35:11 INFO - 'tabpaint']}, 06:35:11 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:35:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:35:11 INFO - 'bloom_basic_ref']}, 06:35:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:35:11 INFO - 'tests': ['tsvgx', 06:35:11 INFO - 'tsvgr_opacity', 06:35:11 INFO - 'tart', 06:35:11 INFO - 'tscrollx', 06:35:11 INFO - 'cart', 06:35:11 INFO - 'tsvg_static']}, 06:35:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:35:11 INFO - 'tsvgr_opacity', 06:35:11 INFO - 'tart', 06:35:11 INFO - 'tscrollx', 06:35:11 INFO - 'cart', 06:35:11 INFO - 'tsvg_static']}, 06:35:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:35:11 INFO - 'talos_options': ['--disable-e10s'], 06:35:11 INFO - 'tests': ['tp5o']}, 06:35:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:35:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:35:11 INFO - 'talos_options': ['--disable-e10s', 06:35:11 INFO - '--xperf_path', 06:35:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:11 INFO - 'tests': ['tp5n']}, 06:35:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:35:11 INFO - 'talos_options': ['--xperf_path', 06:35:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:35:11 INFO - 'tests': ['tp5n']}}, 06:35:11 INFO - 'talos.zip': {'path': '', 06:35:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:35:11 INFO - Running post-action listener: _resource_record_post_action 06:35:11 INFO - [mozharness: 2017-05-12 13:35:11.648323Z] Finished populate-webroot step (success) 06:35:11 INFO - [mozharness: 2017-05-12 13:35:11.648412Z] Running create-virtualenv step. 06:35:11 INFO - Running pre-action listener: _resource_record_pre_action 06:35:11 INFO - Running main action method: create_virtualenv 06:35:11 INFO - Creating virtualenv /builds/slave/test/build/venv 06:35:11 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 06:35:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:35:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:35:11 INFO - Using real prefix '/usr' 06:35:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:35:12 INFO - Installing distribute.............................................................................................................................................................................................done. 06:35:14 INFO - Installing pip.................done. 06:35:14 INFO - Return code: 0 06:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:35:15 INFO - Reading from file tmpfile_stdout 06:35:15 INFO - Output received: 06:35:15 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) 06:35:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:35: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')]} 06:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35: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')]} 06:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc5b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe27a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcaa30>, '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 0xfcb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcbca0>, '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': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', '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 06:35: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', 'pip>=1.5'] in /builds/slave/test/build 06:35: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 pip>=1.5 06:35:15 INFO - Using env: {'DISPLAY': ':0', 06:35:15 INFO - 'HOME': '/home/cltbld', 06:35:15 INFO - 'LANG': 'en_US.UTF-8', 06:35:15 INFO - 'LANGUAGE': 'en_US:en', 06:35:15 INFO - 'LOGNAME': 'cltbld', 06:35:15 INFO - 'MAIL': '/var/mail/cltbld', 06:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:15 INFO - 'MOZ_NO_REMOTE': '1', 06:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:15 INFO - 'NO_EM_RESTART': '1', 06:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:15 INFO - 'PWD': '/builds/slave/test', 06:35:15 INFO - 'SHELL': '/bin/bash', 06:35:15 INFO - 'SHLVL': '1', 06:35:15 INFO - 'TERM': 'linux', 06:35:15 INFO - 'TMOUT': '86400', 06:35:15 INFO - 'USER': 'cltbld', 06:35:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', 06:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:15 INFO - '_': '/tools/buildbot/bin/python'} 06:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:15 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 06:35:15 INFO - Cleaning up... 06:35:15 INFO - Return code: 0 06:35:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:35: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')]} 06:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35: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')]} 06:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35: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', '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 0xc5b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe27a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcaa30>, '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 0xfcb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcbca0>, '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': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', '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 06:35: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:35: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 psutil>=3.1.1 06:35:15 INFO - Using env: {'DISPLAY': ':0', 06:35:15 INFO - 'HOME': '/home/cltbld', 06:35:15 INFO - 'LANG': 'en_US.UTF-8', 06:35:15 INFO - 'LANGUAGE': 'en_US:en', 06:35:15 INFO - 'LOGNAME': 'cltbld', 06:35:15 INFO - 'MAIL': '/var/mail/cltbld', 06:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:15 INFO - 'MOZ_NO_REMOTE': '1', 06:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:15 INFO - 'NO_EM_RESTART': '1', 06:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:15 INFO - 'PWD': '/builds/slave/test', 06:35:15 INFO - 'SHELL': '/bin/bash', 06:35:15 INFO - 'SHLVL': '1', 06:35:15 INFO - 'TERM': 'linux', 06:35:15 INFO - 'TMOUT': '86400', 06:35:15 INFO - 'USER': 'cltbld', 06:35:15 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', 06:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:15 INFO - '_': '/tools/buildbot/bin/python'} 06:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:15 INFO - Downloading/unpacking psutil>=3.1.1 06:35: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 06:35: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 06:35: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 06:35: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 06:35:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:35:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:17 INFO - Installing collected packages: psutil 06:35:17 INFO - Running setup.py install for psutil 06:35:17 INFO - building 'psutil._psutil_linux' extension 06:35:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:35:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:35:18 INFO - building 'psutil._psutil_posix' extension 06:35:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:35:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:35:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:35:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:35:18 INFO - Successfully installed psutil 06:35:18 INFO - Cleaning up... 06:35:18 INFO - Return code: 0 06:35:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:35: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')]} 06:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35: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')]} 06:35:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc5b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe27a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcaa30>, '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 0xfcb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcbca0>, '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': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', '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 06:35:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:35:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:35:18 INFO - Using env: {'DISPLAY': ':0', 06:35:18 INFO - 'HOME': '/home/cltbld', 06:35:18 INFO - 'LANG': 'en_US.UTF-8', 06:35:18 INFO - 'LANGUAGE': 'en_US:en', 06:35:18 INFO - 'LOGNAME': 'cltbld', 06:35:18 INFO - 'MAIL': '/var/mail/cltbld', 06:35:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:18 INFO - 'MOZ_NO_REMOTE': '1', 06:35:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:18 INFO - 'NO_EM_RESTART': '1', 06:35:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:18 INFO - 'PWD': '/builds/slave/test', 06:35:18 INFO - 'SHELL': '/bin/bash', 06:35:18 INFO - 'SHLVL': '1', 06:35:18 INFO - 'TERM': 'linux', 06:35:18 INFO - 'TMOUT': '86400', 06:35:18 INFO - 'USER': 'cltbld', 06:35:18 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', 06:35:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:18 INFO - '_': '/tools/buildbot/bin/python'} 06:35:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:35: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 06:35: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 06:35: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 06:35: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 06:35:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:35:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:35:20 INFO - Installing collected packages: mozsystemmonitor 06:35:20 INFO - Running setup.py install for mozsystemmonitor 06:35:20 INFO - Successfully installed mozsystemmonitor 06:35:20 INFO - Cleaning up... 06:35:20 INFO - Return code: 0 06:35:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc5b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe27a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcaa30>, '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 0xfcb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcbca0>, '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': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', '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 06:35:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:35:20 INFO - Using env: {'DISPLAY': ':0', 06:35:20 INFO - 'HOME': '/home/cltbld', 06:35:20 INFO - 'LANG': 'en_US.UTF-8', 06:35:20 INFO - 'LANGUAGE': 'en_US:en', 06:35:20 INFO - 'LOGNAME': 'cltbld', 06:35:20 INFO - 'MAIL': '/var/mail/cltbld', 06:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:20 INFO - 'MOZ_NO_REMOTE': '1', 06:35:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:20 INFO - 'NO_EM_RESTART': '1', 06:35:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:20 INFO - 'PWD': '/builds/slave/test', 06:35:20 INFO - 'SHELL': '/bin/bash', 06:35:20 INFO - 'SHLVL': '1', 06:35:20 INFO - 'TERM': 'linux', 06:35:20 INFO - 'TMOUT': '86400', 06:35:20 INFO - 'USER': 'cltbld', 06:35:20 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', 06:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:20 INFO - '_': '/tools/buildbot/bin/python'} 06:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:20 INFO - Downloading/unpacking jsonschema==2.5.1 06:35: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 06:35: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 06:35: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 06:35: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 06:35:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:35:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:21 INFO - Downloading functools32-3.2.3-2.tar.gz 06:35:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:35:21 INFO - warning: no files found matching '*.txt' 06:35:21 INFO - no previously-included directories found matching 'build' 06:35:21 INFO - no previously-included directories found matching 'dist' 06:35:21 INFO - no previously-included directories found matching '.git*' 06:35:21 INFO - Installing collected packages: jsonschema, functools32 06:35:21 INFO - Running setup.py install for functools32 06:35:21 INFO - warning: no files found matching '*.txt' 06:35:21 INFO - no previously-included directories found matching 'build' 06:35:21 INFO - no previously-included directories found matching 'dist' 06:35:21 INFO - no previously-included directories found matching '.git*' 06:35:22 INFO - Successfully installed jsonschema functools32 06:35:22 INFO - Cleaning up... 06:35:22 INFO - Return code: 0 06:35:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:22 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 0xc5b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe27a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcaa30>, '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 0xfcb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcbca0>, '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': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', '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 06:35:22 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 06:35:22 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 06:35:22 INFO - Using env: {'DISPLAY': ':0', 06:35:22 INFO - 'HOME': '/home/cltbld', 06:35:22 INFO - 'LANG': 'en_US.UTF-8', 06:35:22 INFO - 'LANGUAGE': 'en_US:en', 06:35:22 INFO - 'LOGNAME': 'cltbld', 06:35:22 INFO - 'MAIL': '/var/mail/cltbld', 06:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:22 INFO - 'MOZ_NO_REMOTE': '1', 06:35:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:22 INFO - 'NO_EM_RESTART': '1', 06:35:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:22 INFO - 'PWD': '/builds/slave/test', 06:35:22 INFO - 'SHELL': '/bin/bash', 06:35:22 INFO - 'SHLVL': '1', 06:35:22 INFO - 'TERM': 'linux', 06:35:22 INFO - 'TMOUT': '86400', 06:35:22 INFO - 'USER': 'cltbld', 06:35:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', 06:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:22 INFO - '_': '/tools/buildbot/bin/python'} 06:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:35:22 INFO - Cleaning up... 06:35:22 INFO - Return code: 0 06:35:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:22 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 0xc5b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe27a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcaa30>, '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 0xfcb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcbca0>, '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': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', '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 06:35:22 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 06:35:22 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 06:35:22 INFO - Using env: {'DISPLAY': ':0', 06:35:22 INFO - 'HOME': '/home/cltbld', 06:35:22 INFO - 'LANG': 'en_US.UTF-8', 06:35:22 INFO - 'LANGUAGE': 'en_US:en', 06:35:22 INFO - 'LOGNAME': 'cltbld', 06:35:22 INFO - 'MAIL': '/var/mail/cltbld', 06:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:22 INFO - 'MOZ_NO_REMOTE': '1', 06:35:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:22 INFO - 'NO_EM_RESTART': '1', 06:35:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:22 INFO - 'PWD': '/builds/slave/test', 06:35:22 INFO - 'SHELL': '/bin/bash', 06:35:22 INFO - 'SHLVL': '1', 06:35:22 INFO - 'TERM': 'linux', 06:35:22 INFO - 'TMOUT': '86400', 06:35:22 INFO - 'USER': 'cltbld', 06:35:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', 06:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:22 INFO - '_': '/tools/buildbot/bin/python'} 06:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:22 INFO - Downloading/unpacking blobuploader==1.2.4 06:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:23 INFO - Downloading blobuploader-1.2.4.tar.gz 06:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:35:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:35:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:24 INFO - Downloading docopt-0.6.1.tar.gz 06:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:35:24 INFO - Installing collected packages: blobuploader, requests, docopt 06:35:24 INFO - Running setup.py install for blobuploader 06:35:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:35:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:35:24 INFO - Running setup.py install for requests 06:35:24 INFO - Running setup.py install for docopt 06:35:24 INFO - Successfully installed blobuploader requests docopt 06:35:24 INFO - Cleaning up... 06:35:24 INFO - Return code: 0 06:35:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35: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')]} 06:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35: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')]} 06:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc5b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe27a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcaa30>, '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 0xfcb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcbca0>, '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': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', '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 06:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:35:24 INFO - Using env: {'DISPLAY': ':0', 06:35:24 INFO - 'HOME': '/home/cltbld', 06:35:24 INFO - 'LANG': 'en_US.UTF-8', 06:35:24 INFO - 'LANGUAGE': 'en_US:en', 06:35:24 INFO - 'LOGNAME': 'cltbld', 06:35:24 INFO - 'MAIL': '/var/mail/cltbld', 06:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:24 INFO - 'MOZ_NO_REMOTE': '1', 06:35:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:24 INFO - 'NO_EM_RESTART': '1', 06:35:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:24 INFO - 'PWD': '/builds/slave/test', 06:35:24 INFO - 'SHELL': '/bin/bash', 06:35:24 INFO - 'SHLVL': '1', 06:35:24 INFO - 'TERM': 'linux', 06:35:24 INFO - 'TMOUT': '86400', 06:35:24 INFO - 'USER': 'cltbld', 06:35:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', 06:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:24 INFO - '_': '/tools/buildbot/bin/python'} 06:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:35:24 INFO - Running setup.py (path:/tmp/pip-E3AEgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:35:25 INFO - Running setup.py (path:/tmp/pip-HjODH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:35:25 INFO - Running setup.py (path:/tmp/pip-xwckEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:35:25 INFO - Running setup.py (path:/tmp/pip-h8g_Xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:35:25 INFO - Running setup.py (path:/tmp/pip-1dUV1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:35:25 INFO - Running setup.py (path:/tmp/pip-rXiIHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:35:25 INFO - Running setup.py (path:/tmp/pip-QKw4zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:35:25 INFO - Running setup.py (path:/tmp/pip-n2NqSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:35:25 INFO - Running setup.py (path:/tmp/pip-jaHJgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:35:25 INFO - Running setup.py (path:/tmp/pip-XBt4Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:35:25 INFO - Running setup.py (path:/tmp/pip-MJ4Qsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:35:25 INFO - Running setup.py (path:/tmp/pip-MPXfWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:35:25 INFO - Running setup.py (path:/tmp/pip-8zx5Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:35:25 INFO - Running setup.py (path:/tmp/pip-VzArvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:25 INFO - Running setup.py (path:/tmp/pip-bJQm84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:35:26 INFO - Running setup.py (path:/tmp/pip-AWqZ1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:35:26 INFO - Running setup.py (path:/tmp/pip-WNRP7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:35:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:35:26 INFO - Running setup.py install for manifestparser 06:35:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:35:26 INFO - Running setup.py install for mozcrash 06:35:26 INFO - Running setup.py install for mozdebug 06:35:26 INFO - Running setup.py install for mozdevice 06:35:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:35:26 INFO - Running setup.py install for mozfile 06:35:26 INFO - Running setup.py install for mozhttpd 06:35:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:35:26 INFO - Running setup.py install for mozinfo 06:35:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:35:26 INFO - Running setup.py install for mozInstall 06:35:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:35:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:35:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:35:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:35:26 INFO - Running setup.py install for mozleak 06:35:27 INFO - Running setup.py install for mozlog 06:35:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:35:27 INFO - Running setup.py install for moznetwork 06:35:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:35:27 INFO - Running setup.py install for mozprocess 06:35:27 INFO - Running setup.py install for mozprofile 06:35:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:35:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:35:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:35:27 INFO - Running setup.py install for mozrunner 06:35:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:35:27 INFO - Running setup.py install for mozscreenshot 06:35:27 INFO - Running setup.py install for moztest 06:35:27 INFO - Running setup.py install for mozversion 06:35:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:35:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:35:27 INFO - Cleaning up... 06:35:27 INFO - Return code: 0 06:35:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35: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')]} 06:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35: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')]} 06:35:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc5b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe27a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcaa30>, '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 0xfcb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcbca0>, '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': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', '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 06:35:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:35:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:35:27 INFO - Using env: {'DISPLAY': ':0', 06:35:27 INFO - 'HOME': '/home/cltbld', 06:35:27 INFO - 'LANG': 'en_US.UTF-8', 06:35:27 INFO - 'LANGUAGE': 'en_US:en', 06:35:27 INFO - 'LOGNAME': 'cltbld', 06:35:27 INFO - 'MAIL': '/var/mail/cltbld', 06:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:27 INFO - 'MOZ_NO_REMOTE': '1', 06:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:27 INFO - 'NO_EM_RESTART': '1', 06:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:27 INFO - 'PWD': '/builds/slave/test', 06:35:27 INFO - 'SHELL': '/bin/bash', 06:35:27 INFO - 'SHLVL': '1', 06:35:27 INFO - 'TERM': 'linux', 06:35:27 INFO - 'TMOUT': '86400', 06:35:27 INFO - 'USER': 'cltbld', 06:35:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', 06:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:27 INFO - '_': '/tools/buildbot/bin/python'} 06:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:35:28 INFO - Running setup.py (path:/tmp/pip-xeomWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:35:28 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)) 06:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:35:28 INFO - Running setup.py (path:/tmp/pip-UeK63R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:35:28 INFO - Running setup.py (path:/tmp/pip-i60Sul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:35:28 INFO - Running setup.py (path:/tmp/pip-T_8IEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:35:28 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)) 06:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:35:28 INFO - Running setup.py (path:/tmp/pip-qykJS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:35:28 INFO - Running setup.py (path:/tmp/pip-NcwYUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:35:28 INFO - Running setup.py (path:/tmp/pip-WdKdU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:35:28 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)) 06:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:35:28 INFO - Running setup.py (path:/tmp/pip-_QGQj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:35:28 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)) 06:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:35:28 INFO - Running setup.py (path:/tmp/pip-SXKU8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:35:28 INFO - Running setup.py (path:/tmp/pip-z0paXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:35:28 INFO - Running setup.py (path:/tmp/pip-Uso4JE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:35:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:35:28 INFO - Running setup.py (path:/tmp/pip-ykufvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:35:29 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)) 06:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:35:29 INFO - Running setup.py (path:/tmp/pip-rJ5sXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:35:29 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)) 06:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:35:29 INFO - Running setup.py (path:/tmp/pip-NKd4GG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:35:29 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)) 06:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:29 INFO - Running setup.py (path:/tmp/pip-q0GjD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:35:29 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)) 06:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:35:29 INFO - Running setup.py (path:/tmp/pip-yGKyrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:35:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:35:29 INFO - Running setup.py (path:/tmp/pip-SK29FR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:35:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:35:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:35:30 INFO - Downloading blessings-1.6.tar.gz 06:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:35:30 INFO - Installing collected packages: blessings 06:35:30 INFO - Running setup.py install for blessings 06:35:30 INFO - Successfully installed blessings 06:35:30 INFO - Cleaning up... 06:35:30 INFO - Return code: 0 06:35:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:35:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:35:30 INFO - Reading from file tmpfile_stdout 06:35:30 INFO - Current package versions: 06:35:30 INFO - argparse == 1.2.1 06:35:30 INFO - blessings == 1.6 06:35:30 INFO - blobuploader == 1.2.4 06:35:30 INFO - docopt == 0.6.1 06:35:30 INFO - functools32 == 3.2.3-2 06:35:30 INFO - jsonschema == 2.5.1 06:35:30 INFO - manifestparser == 1.1 06:35:30 INFO - mozInstall == 1.12 06:35:30 INFO - mozcrash == 1.0 06:35:30 INFO - mozdebug == 0.1 06:35:30 INFO - mozdevice == 0.50 06:35:30 INFO - mozfile == 1.2 06:35:30 INFO - mozhttpd == 0.7 06:35:30 INFO - mozinfo == 0.9 06:35:30 INFO - mozleak == 0.1 06:35:30 INFO - mozlog == 3.4 06:35:30 INFO - moznetwork == 0.27 06:35:30 INFO - mozprocess == 0.25 06:35:30 INFO - mozprofile == 0.28 06:35:30 INFO - mozrunner == 6.13 06:35:30 INFO - mozscreenshot == 0.1 06:35:30 INFO - mozsystemmonitor == 0.3 06:35:30 INFO - moztest == 0.8 06:35:30 INFO - mozversion == 1.4 06:35:30 INFO - psutil == 3.1.1 06:35:30 INFO - requests == 1.2.3 06:35:30 INFO - wsgiref == 0.1.2 06:35:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc5b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe27a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcaa30>, '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 0xfcb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcbca0>, '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': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', '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 06:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:35:30 INFO - Using env: {'DISPLAY': ':0', 06:35:30 INFO - 'HOME': '/home/cltbld', 06:35:30 INFO - 'LANG': 'en_US.UTF-8', 06:35:30 INFO - 'LANGUAGE': 'en_US:en', 06:35:30 INFO - 'LOGNAME': 'cltbld', 06:35:30 INFO - 'MAIL': '/var/mail/cltbld', 06:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:30 INFO - 'MOZ_NO_REMOTE': '1', 06:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:30 INFO - 'NO_EM_RESTART': '1', 06:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:30 INFO - 'PWD': '/builds/slave/test', 06:35:30 INFO - 'SHELL': '/bin/bash', 06:35:30 INFO - 'SHLVL': '1', 06:35:30 INFO - 'TERM': 'linux', 06:35:30 INFO - 'TMOUT': '86400', 06:35:30 INFO - 'USER': 'cltbld', 06:35:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', 06:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:30 INFO - '_': '/tools/buildbot/bin/python'} 06:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:31 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)) 06:35:31 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)) 06:35:31 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)) 06:35:31 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)) 06:35:31 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)) 06:35:31 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)) 06:35:31 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)) 06:35:31 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)) 06:35:31 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)) 06:35:31 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)) 06:35:31 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)) 06:35:31 INFO - Cleaning up... 06:35:31 INFO - Return code: 0 06:35:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:35:31 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')]} 06:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:35:31 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')]} 06:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:35:31 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 0xc5b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe27a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfcd770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfcaa30>, '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 0xfcb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcbca0>, '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': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', '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 06:35:31 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 06:35:31 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 06:35:31 INFO - Using env: {'DISPLAY': ':0', 06:35:31 INFO - 'HOME': '/home/cltbld', 06:35:31 INFO - 'LANG': 'en_US.UTF-8', 06:35:31 INFO - 'LANGUAGE': 'en_US:en', 06:35:31 INFO - 'LOGNAME': 'cltbld', 06:35:31 INFO - 'MAIL': '/var/mail/cltbld', 06:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:31 INFO - 'MOZ_NO_REMOTE': '1', 06:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:31 INFO - 'NO_EM_RESTART': '1', 06:35:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:31 INFO - 'PWD': '/builds/slave/test', 06:35:31 INFO - 'SHELL': '/bin/bash', 06:35:31 INFO - 'SHLVL': '1', 06:35:31 INFO - 'TERM': 'linux', 06:35:31 INFO - 'TMOUT': '86400', 06:35:31 INFO - 'USER': 'cltbld', 06:35:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', 06:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:31 INFO - '_': '/tools/buildbot/bin/python'} 06:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:35:31 INFO - Cleaning up... 06:35:31 INFO - Return code: 0 06:35:31 INFO - Running post-action listener: _resource_record_post_action 06:35:31 INFO - Running post-action listener: _start_resource_monitoring 06:35:31 INFO - Starting resource monitoring. 06:35:31 INFO - [mozharness: 2017-05-12 13:35:31.474213Z] Finished create-virtualenv step (success) 06:35:31 INFO - [mozharness: 2017-05-12 13:35:31.475146Z] Running install step. 06:35:31 INFO - Running pre-action listener: _resource_record_pre_action 06:35:31 INFO - Running main action method: install 06:35:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:35:31 INFO - Reading from file tmpfile_stdout 06:35:31 INFO - Detecting whether we're running mozinstall >=1.0... 06:35:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:35:31 INFO - Reading from file tmpfile_stdout 06:35:31 INFO - Output received: 06:35:31 INFO - Usage: mozinstall [options] installer 06:35:31 INFO - Options: 06:35:31 INFO - -h, --help show this help message and exit 06:35:31 INFO - -d DEST, --destination=DEST 06:35:31 INFO - Directory to install application into. [default: 06:35:31 INFO - "/builds/slave/test"] 06:35:31 INFO - --app=APP Application being installed. [default: firefox] 06:35:31 INFO - mkdir: /builds/slave/test/build/application 06:35:31 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'] 06:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:35:47 INFO - Reading from file tmpfile_stdout 06:35:47 INFO - Output received: 06:35:47 INFO - /builds/slave/test/build/application/firefox/firefox 06:35:47 INFO - Running post-action listener: _resource_record_post_action 06:35:47 INFO - [mozharness: 2017-05-12 13:35:47.656514Z] Finished install step (success) 06:35:47 INFO - [mozharness: 2017-05-12 13:35:47.656761Z] Running run-tests step. 06:35:47 INFO - Running pre-action listener: _resource_record_pre_action 06:35:47 INFO - Running main action method: run_tests 06:35:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:35:47 INFO - Python 2.7.3 06:35:47 INFO - Return code: 0 06:35:47 INFO - grabbing minidump binary from tooltool 06:35:47 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')]} 06:35:47 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 0xfcaa30>, '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 0xfcb7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfcbca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:35:47 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 06:35:47 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 06:35:47 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 06:35:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:35:47 INFO - Return code: 0 06:35:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:35:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:35:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:35:47 INFO - ENV: RUST_BACKTRACE is now 1 06:35:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:35:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:35:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 06:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 06:35:47 INFO - Using env: {'DISPLAY': ':0', 06:35:47 INFO - 'HOME': '/home/cltbld', 06:35:47 INFO - 'LANG': 'en_US.UTF-8', 06:35:47 INFO - 'LANGUAGE': 'en_US:en', 06:35:47 INFO - 'LOGNAME': 'cltbld', 06:35:47 INFO - 'MAIL': '/var/mail/cltbld', 06:35:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:35:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:35:47 INFO - 'MOZ_NO_REMOTE': '1', 06:35:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:35:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:35:47 INFO - 'NO_EM_RESTART': '1', 06:35:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:35:47 INFO - 'PWD': '/builds/slave/test', 06:35:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:35:47 INFO - 'RUST_BACKTRACE': '1', 06:35:47 INFO - 'SHELL': '/bin/bash', 06:35:47 INFO - 'SHLVL': '1', 06:35:47 INFO - 'TERM': 'linux', 06:35:47 INFO - 'TMOUT': '86400', 06:35:47 INFO - 'USER': 'cltbld', 06:35:47 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628', 06:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:35:47 INFO - '_': '/tools/buildbot/bin/python'} 06:35:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 06:35:48 INFO - mozversion application_buildid: 20170512123443 06:35:48 INFO - mozversion application_changeset: bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 06:35:48 INFO - mozversion application_display_name: Nightly 06:35:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:35:48 INFO - mozversion application_name: Firefox 06:35:48 INFO - mozversion application_remotingname: firefox 06:35:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:35:48 INFO - mozversion application_vendor: Mozilla 06:35:48 INFO - mozversion application_version: 55.0a1 06:35:48 INFO - mozversion platform_buildid: 20170512123443 06:35:48 INFO - mozversion platform_changeset: bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 06:35:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:35:48 INFO - mozversion platform_version: 55.0a1 06:35:48 INFO - using testdate: 1494596148 06:35:48 INFO - actual date: 1494596148 06:35:48 INFO - starting webserver on 'localhost:48624' 06:35:48 INFO - SUITE-START | Running 2 tests 06:35:48 INFO - TEST-START | dromaeo_css 06:35:48 INFO - operating with platform_type : linux_ 06:35:48 INFO - Initialising browser for dromaeo_css test... 06:35:48 INFO - TEST-INFO | started process 3293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2oSnao/profile http://localhost:48624/getInfo.html) 06:35:53 INFO - PID 3293 | __metrics Screen width/height:1600/1200 06:35:53 INFO - PID 3293 | colorDepth:24 06:35:53 INFO - PID 3293 | Browser inner width/height: 1024/695 06:35:53 INFO - PID 3293 | __metrics 06:35:54 INFO - PID 3293 | 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" 06:35:54 INFO - PID 3293 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:35:55 INFO - TEST-INFO | 3293: exit 0 06:35:55 INFO - Browser initialized. 06:35:55 INFO - Running cycle 1/1 for dromaeo_css test... 06:35:55 INFO - TEST-INFO | started process 3391 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2oSnao/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:36:07 INFO - PID 3391 | RSS: Main: 149417984 06:36:07 INFO - PID 3391 | 06:39:14 INFO - PID 3391 | Cycle 1(1): loaded http://localhost:48624/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48624/tests/dromaeo/cssquery-ext.html) 06:39:15 INFO - PID 3391 | RSS: Main: 296726528 06:39:15 INFO - PID 3391 | 06:42:18 INFO - PID 3391 | Cycle 1(1): loaded http://localhost:48624/tests/dromaeo/cssquery-ext.html (next: http://localhost:48624/tests/dromaeo/cssquery-jquery.html) 06:42:18 INFO - PID 3391 | RSS: Main: 233095168 06:42:18 INFO - PID 3391 | 06:45:20 INFO - PID 3391 | Cycle 1(1): loaded http://localhost:48624/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48624/tests/dromaeo/cssquery-mootools.html) 06:45:21 INFO - PID 3391 | RSS: Main: 218406912 06:45:21 INFO - PID 3391 | 06:48:23 INFO - PID 3391 | Cycle 1(1): loaded http://localhost:48624/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48624/tests/dromaeo/cssquery-prototype.html) 06:48:24 INFO - PID 3391 | RSS: Main: 218857472 06:48:24 INFO - PID 3391 | 06:51:27 INFO - PID 3391 | Cycle 1(1): loaded http://localhost:48624/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48624/tests/dromaeo/cssquery-yui.html) 06:51:27 INFO - PID 3391 | RSS: Main: 179437568 06:51:27 INFO - PID 3391 | 06:54:29 INFO - PID 3391 | Cycle 1(1): loaded http://localhost:48624/tests/dromaeo/cssquery-yui.html (next: http://localhost:48624/tests/dromaeo/cssquery-dojo.html) 06:54:30 INFO - PID 3391 | RSS: Main: 266305536 06:54:30 INFO - PID 3391 | 06:54:30 INFO - PID 3391 | __start_tp_report 06:54:30 INFO - PID 3391 | _x_x_mozilla_page_load 06:54:30 INFO - PID 3391 | _x_x_mozilla_page_load_details 06:54:30 INFO - PID 3391 | |i|pagename|runs| 06:54:30 INFO - PID 3391 | |0;dojo.html;2669.4394177222784;2670.8130430869833;2702.689190743064;2705.364239403741;2710.769584585311;5063.4177069637;5140.43455219926;5168.896622067566;5178.637495375326;5217.087009773293;5055.772490237939;5091.872703182432;5103.515166059227;5147.81982630608;5163.7418129093485;4259.446271984638;4512.323151527265;4543.091381723652;4618.214903466419;4636.3740894979255;4560.749158796281;4600.907981840344;4627.953720462803;4646.4191976003;4659.976700116512;4501.392312037866;4535.365048893158;4567.474740404863;4581.61056310214;4604.58558729716;4564.748938808364;4567.497575266718;4608.101420223058;4611.44662640482;4631.397918270603;4504.121696269229;4536.818527258905;4540.545945405466;4559.110973360196;4604.332371806069;5044.369453818273;5113.335266415343;5116.820911268088;5117.667351622133;5120.692758434506;5507.586930980193;5518.144687573433;5520.033994051065;5521.171824226358;5530.419305972895;5512.090505066659;5529.695866727328;5536.307961504812;5538.280023596906;5540.833774986757;5096.643234973516;5148.150555158357;5148.304978827885;5158.071547121479;5158.767855446439;5627.21219029328;5632.802851900164;5667.801626943037;5669.546436285087;5678.77284908599;5442.482964118402;5449.155380915964;5476.780928762884;5486.780528778884;5496.7526461309335;5530.225768392428;5534.640248383923;5538.47384498472;5540.252065971043;5546.251256080458;5425.647332923348;5483.013057649661;5497.670139791625;5504.862378440491;5544.362398324244;5470.425605311465;5482.91775623366;5483;5495.34055913285;5498.422665620133;4611.930821037688;4679.836205732851;4716.292556116541;4717.905641887143;4718.528147185254;3993.0616305168264;4005.4592629994577;4014.1369605534364;4014.759114453142;4044.716869819143;4681.50844161365;4684.273937539687;4685.8594242172785;4733.502982186821;4734.928976065362;5487.286652735199;5547.33431988164;5553;5555.583331250092;5598.944010559842;4703.64722645803;4710.81156753726;4713.151632706145;4715.151272770866;4718.150732868048;4970.105381031377;4971.801127954914;4972.378452693413;4976.104301225814;4977.253411988231;4484.977575112103;5036.672616280003;5100.056489549445;5102.566281866083;5148.845534633967;5502.58730595215;5573.052581061311;5578.163275508706;5592.804251851166;5624.943750562442;5048.848534543969;5085.7457127144235;5128.153854614096;5129.179331306973;5137.717425541631;5449.64577302474;5453.863653408696;5459.617826752089;5460;5470.17947307907;5486.753096110764;5547.33431988164;5556.249906262765;5580.665160090408;5605.523530499953;5340.279062326536;5368;5427.592930530305;5435.619506634655;5453.7818487260065;5393.595480339069;5400.351957765093;5405.054115529845;5409;5409.269748583891;5317.548008419173;5318.547923426398;5327.467253274796;5328.946710532845;5377.838664840061;5276.472352764847;5309.309789727311;5399.78400863961;5406.540444062299;5410.810621628224;5174.353205849269;5211.4527974562125;5222.895542089061;5275.498827611371;5302.522772950453 06:54:30 INFO - PID 3391 | |1;ext.html;640.2477089419933;697.8988046733224;716.5449939288552;995.1143482300749;1014.4674046125788;25969.74030259697;30524.694753052463;33416.832915835446;33519.32961340775;33533.83233083831;35050.29899402011;35437.2912541749;35466.64533354666;35478.467822982675;35486.82256588714;5203.557697595709;6805.217399999002;6958.8956165657555;6960.547564408323;6963;5270.5520030797425;6630.8010759677045;6755.425788807957;6756.49326300527;6810;6786.457083433338;6845.931540684604;6848.794536163899;6856.41720453762;6856.760013399532;5194.948050519484;6762.560433571826;6814.52298339114;6816.250212476623;6877.690503927335;5058.215976523645;6731.697073631698;6878.69045892936;6880.69036893341;6884.311568843125;30985;31445;31558.368832623448;31600.683993160004;31615.20961975946;3027.6518200407013;3069.0639354996715;3071.6467606225347;3072.9846350768103;3073.8155710657434;24050.518989620283;24082.397940051465;24111.758882411126;24137;24143;3190.0429871038596;3207.4386982278243;3216.6300875399393;3227.402930457873;3227.5158726191257;131891.34054329764;132427.33786331103;132533;132548;132760;39769.20461590752;39810;39861;39877.80061099676;39892.60107398889;41700.582994170276;41720.37419438711;41759.58240417617;41853.55903732556;41862.58137418648;13115.344232788513;13177.670558236121;13181.143225690299;13204.537841175705;13218.471261149447;8261.83476330482;8427.578621068922;10703.304285221435;10769.299995500267;10779.78440431187;11354.659360219206;11509.48207330672;11533.826992595117;11693.239939403911;11702.88297117035;4832.34763306949;4885.975570122127;4892.217245240816;4895.412550493964;4899.58353539946;893.2942975049768;897.0446474504631;910.0899100899101;922.760082378573;933.8412469880137;20613.896930515253;20667.379978600668;21145.894270528548;21257.255996040065;21404.357869263946;957.8323793336277;967.9758006049905;973.8149751547184;990.1633120013577;997.755549890267;10746.301490403099;11145.721356965978;11238.494267757971;11270.661880143609;11362.375069371099;151663;151710;152350;152635.23682381518;153806.23096884444;39689.603103969166;39792.40311395331;39817.40273895894;39835.20329593392;39860.402093968616;1186.8635106962638;1219.9634010979685;1222.9449674764658;1225.724212052281;1230.5693007447321;19735.506612334808;19751.40745777629;19979.700304495153;20872.68690969667;21233.15067397287;29216.415671686023;29250.561241581818;29261.414771704873;29285.70714292915;29287.12138635844;137484.31257843648;137601;137733.3113334427;138313;139354;28661.14016579506;28706.856465718374;28710.569341459475;28875.278118047216;29730.256743581584;36031.27937441289;36122.819385902905;36209.27581448304;36367.27265454729;36659.266814663024;25934.17569794751;27725.584116237867;27842.721572784012;28427.43145137127;28575.857120714263;27163.86418067897;27424.862875685492;27873.58189627198;28044.298892527033;28831.423371532033;29459.705402945696;30001;30395;30645;30823.383532329677;26191.738082619693;26249.868750656125;26391.34021649474;26921.326966825203;27928.30179245535;20319.288824891057;21380.572388552453;21552.676709849053;21639.675404868623;21682 06:54:30 INFO - PID 3391 | |2;jquery.html;378.334131927807;405.10269752498226;407.3929844531647;417.95611460796613;423.36706623597723;11434.25677330973;13010.869891301085;16999.49001529953;17119;17137.65724685507;18959.14683839227;18959.33642322519;19264.422067337968;19374.70937935932;19511;5551.833444996657;5701.572382071361;5706.543476521868;5711.485966263035;5723.399043100477;3948.190620922718;5661.377248502661;5697.914531282034;5700.37295897451;5701.515371193454;5538.777934738655;5650.124230744221;5663.1505274208785;5665.093585026397;5678.119891416837;5601.383847776741;5687.431256874321;5697.003024470701;5697.715114244271;5701;5044.186475399612;5113;5134.486551344873;5149.3305870237;5152.871178220575;21668.34994950154;22207.66688499674;22295.108195672154;22446.98988545503;22785.20251791179;1596.1061805388904;1630.4049022106847;1633.0691505841676;1634.7220972434714;1636.8035835699793;13981.483333000057;14751.852481475154;14826;14860.108393496317;14891.478798242119;2038.5005673609912;2041.1427200575645;2052.8255098316663;2075.8754474731563;2086.926957556478;72233.63883180551;87347.56326218392;87979.56010219971;89397.99999999935;92709;10589.311694739818;10597;10871.45642717861;11190.888091118984;11431.314121152758;14872.553823385315;14893.553193404216;14902.180380078982;14997.400103995937;15011.099334039993;7447.218042105609;7605.277498637621;7695.923040769632;7775.261350171724;7869.881951770728;7057.964710176519;7075.71697132109;7141.214466408691;7300.853982920312;7352.397325310666;6834.829129271808;6901.137357830271;6908.9309106909295;6980.371766541036;6985.746878296514;1991.3030439346112;2038.3069756282935;2054.4555692741437;2079.5840831833393;2233.1514024670846;841.5287439034161;867.8307729992591;871.8387098386819;873.2359185712502;899.680613382253;16689.24898379576;17018.404355847484;17197.65604687924;17244;17732.379366722103;888.0808363343908;888.4180861535705;888.4891187567175;888.6045709659139;908.5502676175336;9247.26021918245;9620;9665.081817227352;9727.708168754949;9762.170215531618;337506;341719;342343;347072;347324;78286;78559;79229.20770792218;79505.80741288885;80484;1067.7117178361955;1074.8280275156094;1122.5565901469038;1124.3197865291381;1126.5043380912537;16630.58423539373;17449.912750436673;17818.732719009484;18158.546036348667;18521.72217416767;36335.27329453449;37273.440898386005;38373;38594.42108368433;39655.206895861345;47995.28007079827;48017.27974080322;48042.5195748038;48076.7596162031;50668.23997640112;8311.210435008665;8403.117672644528;8566.357523185661;8592.871106933526;8920.330975177018;12585.307808070644;12817;12881.355932203165;12949.54676586315;13143;10676.62631807883;11099.778004439704;11242.66272011841;11595.5941542049;11630.88369116298;10320.587176512856;10559.78880422372;10651.147908167482;10856.674299771019;10877.836832447678;10925.726856828325;10964.232503724663;11356.772864542829;11400.94299528497;11414.94292528532;8324.83350333002;8401.915980840113;8579.2707619853;8633.30933525304;8699.521526316114;10426;10588.735281618021;10877.347359158475;11080.335179889233;11169.441527923409 06:54:30 INFO - PID 3391 | |3;mootools.html;1245.9314737689426;1284.6980959474522;1292.5669900583307;1299.3178581244852;1301.9218846869182;9907.950460247697;10266.230032747537;10314.896851031488;10342.482875856205;10352.948235258831;10112.646057387992;10139.847902281472;10588.576456941713;10673.412962287071;10688;2227.543353612514;2267.2744721689064;2271.046160612547;2271.4434963433982;2271.9091236350528;2157.611629906616;2277.703898493202;2280.270313499681;2281.441046943501;2285.394370491821;1755.1750677181703;1820.6813807583685;1822.7174787907895;1826.141713394709;1828.076821205296;1981.1382048808741;2161.6325224711836;2319.2810228829117;2324.4421338878715;2327.336709037933;2266.7393249776324;2304.043821813945;2308.7575804540447;2311.5954707926044;2317.119494592061;9941.552630131662;10059.245556583286;10068.04353586408;10092.798144037151;10108.292419530635;4892.486288939681;5072.51811077947;5079.187330027178;5086.389633243997;5087.771050302708;3294.769366144371;3437.071990562534;3441.776284541497;3453.4129198036394;3466.791992480459;1026.7741096958657;1081.8701755789355;1094.8357746338033;1107.2526044919728;1117.7149826794116;14805.333759980718;15132.773008404993;15133.092014479056;15136.167510787012;15139.243037848064;5050.84847454577;5231.947680523146;5235.05768961583;5272.9736351318;5273.551748101378;12740;12748.490060397666;12749.553765618159;12749.872501275055;12763.553275635308;5871.941280587225;5881.852953676193;5883.588148829626;5884.293884733859;5886.970565147147;5066.569341605931;5202.817901373433;5248.711320877312;5251.868703282448;5273;4184.581541845791;4283.871483855427;4326.826926922888;4331.848385306499;4340.414044104069;1288.884000439965;1317.762802695505;1328.2163523520976;1341.9329033548283;1348.8179095822134;684.9315068493211;705.992940070603;708.6988030087192;726.6621021225155;729.234303980818;5305.602079844027;5360.812371566976;5416.0521908666615;5419.403865574784;5477.863053423616;515.317204703769;526.8419474157737;527.9894402111936;528.4583302115286;530.3158924986801;3524.7708898922;3711.1278849470355;3737.1965027519213;3774.5470543534952;4008.9198216036098;13079.476820927246;13295.601131966056;13398.732025359439;13419.396127174301;13476.5283215087;12862.678433039062;13302.866971330162;13304.135231210133;13329.600111996462;13339.466421343037;7475.70097196117;7672.4629275951265;7687.692492300357;7689.999999999888;7696.307332340004;5899.321578018583;6108.205933228652;6195.81412557624;6325.272593651789;6343.9682801585695;11612.593559225386;11864.703382415508;11866.347350895783;12014.519419223483;12029.15795894314;12245.14284000147;12288.078394120297;12464;12465.688357791129;12487.625371238513;8012.759617211493;8188.058373287148;8201.671933122609;8360.414770966217;8530.274926631306;9860.950695246765;9925.454100024279;9948;9954.950225248827;9959.651412200828;8176.7955801105445;8184.959075204586;8225.547594882339;8301.875471868048;8419.915800841913;8103.392245581487;8248.628811703607;8256.463329883538;8320.50076995358;8479.95760021196;7552.207018263003;7590.658420371207;7623.352015078781;7641.235876412315;7688.961555192188;4439.4228750263555;5375.4087050425205;5406.486383793534;5419.132938729785;5681.863627274479;5281;5432;5442.918356224739;5463.562914966873;5712.257406537124 06:54:30 INFO - PID 3391 | |4;prototype.html;365.90669379308275;382.2660491855637;384.39265959783546;390.5645205595762;391.41483482194104;5313.548348390386;5331.2003199519995;5343.946560534394;5383.811566595175;5398.4601539846;5043.495650434955;5204.219367094937;5209.86975325617;5216.9478305216935;5229.2156176573435;3964.2864284428933;3972.483577134976;3985.720999530034;3993.8602148924792;4000.119973605802;3965.583613720561;3977.6618987385964;3978.5225772907293;3982.1836523512757;3997.900052498682;3771.321162190818;3907.2185562887535;3930.921381572381;3942.073612701013;3952.8221230044574;3882.301185786557;3914.6868250539887;3921.3725803871384;3926.4699265599065;3928.941065884014;3436.862525498977;3443.1908501502126;3454.6890779829937;3455.1534873956043;3456.6197718250974;5021.874453138665;5097;5150.613703972217;5156.613254005964;5166.896662066738;4593.44878614565;4597.793099310539;4604.125216208943;4629.189891768927;4641.234196357597;5491.313585801775;5491.807786727445;5506.201600767866;5508.366537848158;5517.779288828442;3769.2649933263024;3837.7505462144873;3847.1343947611845;3853.8265778040054;3862.053796819769;5539.89483996083;5649.723160566861;5690.829275121753;5708.942910570924;5838.474537291621;3924.6860251179837;3932.390479475686;3933.9606603934167;3944.2703099926607;3952.2688302663523;3980.7014473914574;3988.8831127284407;3990.4413382126527;3993.0616305168264;4003.779792111462;4393.934090988638;4488.259437192892;4495.348174514677;4560.840370587013;4561.29299958507;5532.75102620375;5534.667919924817;5541.722913854291;5544.91682624761;5553.361363443256;1367.3573420492353;1367.9110857794212;1375.3192169875977;1377.5040985245303;1379.379279324308;918.3892711347013;918.5499105438287;919.995400023009;921.9953900230456;923.132255679659;4829.850716431154;4833.830815921426;4836.250381190851;4842.903141937141;4865.172920603506;5753.741081651252;5759.712014399263;5780.566457515703;5781.797637082682;5783.508401785811;4707.552782485658;4766.904661906812;4773.9761301193275;4799.856004319876;4842.465000549548;2995.400919816002;3014.2464383904025;3019.3206528531346;3027.7729170312314;3035.711607397294;5195.3246078009615;5263.815766448232;5269.683818970874;5317.867053323698;5321.494458026481;5800.9129863052085;5843.5909486336395;5851.268591426072;5857.70711464425;5859.736311865976;5268.2361057647195;5292.444293349143;5299.364076310713;5302.416734159317;5304.761285742151;5508.697021663686;5690.544756419559;5719.771209151754;5753.683547404933;5760.1935728998815;5365.812196573102;5639.731060511353;5640.743702519026;5661.688607126647;5666.829995100154;5098.41368242642;5226.40076732473;5299.549538289289;5302.39022512416;5314.734263286898;3940.960590394059;3944.1520073183256;3946.58560851118;3952.3281042222316;3952.782596957195;5610.186522954067;5738.770449181986;5739.167820665896;5779.7110144493445;5795.130730390307;5555.111182210827;5574.331080270394;5576.163575463713;5577.832665020056;5586.916196256978;5545.112781955029;5575.526080283222;5583.748731307182;5587.413321601336;5615.775368985195;5250.842474725764;5446.972765136149;5488.17677348401;5528.308961379827;5543.556515478833;5615.438456154516;5620.943790562042;5622.269105016322;5629.437056294338;5635.6618602883955;5372.919406208988;5440.374356949002;5444.918326225031;5449.918251226314;5467.20725494809 06:54:30 INFO - PID 3391 | |5;yui.html;650.3593959949446;671.7783131566581;731.7877815433521;744.7542311037356;768.7117331000875;13554.728905421885;14035.087719298239;14054.086484378508;14066.929665351672;14170.787438188423;13556.389962451689;15634.530964071068;15681.764773528406;15848.3660653574;15869.127198004106;869.3002133282705;889.4263200235844;889.5196593839319;889.6619284671816;893.8033632600817;898.1647068226547;901.6799036342103;902.2511315608062;902.3593248793364;902.512643172686;925.3661242049184;925.509479975614;925.8379783537888;926.2867591954191;926.3654396738223;920.7375897869109;927.679950417105;929.159111004542;934.9719508414759;939.1641439119189;666.8132922781629;667.4993754683987;673.0375562944987;674.9628770417625;688.4526801193064;14367.78448323276;14397.20815355155;14571.489997850025;14572.562823115324;14600.269986500738;15310.464133755377;15408.53774386759;15724.449644262397;15741.606459838482;15747.448839290684;12307.815382769177;12492.875071249353;12530.122891397607;12531.624051278384;12546.247225166428;2953.616029916097;2980.955285670717;3012.3824615953895;3035.04396115223;3042.4827779277575;69413;70555.29444705539;70749.64625176892;71647.28352716459;71901.20246993867;11480;11685.240459370114;11798.764024719458;12325.322107284006;12575.93712031434;21573;21995.340139795833;22027.33917982463;22136.557268854856;22788.43028924257;6138.7237574309265;6242.937570624235;6254.312025677172;6257.124002639634;6261.279952805486;3017.170278173476;3096.210466331071;3124.7500199983947;3150.054983504939;3150.417172823035;3547.237343971007;3586.5875424326537;3588.9102772430897;3622.945655815165;3624.655657712513;716.2944499667823;732.802143421284;745.8247311881703;752.6086435053742;754.1402800807084;573.4122524412427;582.2343618142214;592.1413949772847;596.6151832068292;604.5707547641136;9038.63845446188;9433.669821556212;9614.471204083702;9732.36739611937;9753.512324383752;590.7961753195141;596.7463827873137;599.6821684507219;605.6003037994902;621.5711159300068;4518.796654150571;4546.522615125365;4566.543345665407;4573.839915602938;4597.218472859622;59301.40698593045;60375;60999.39000610026;61510.69244653748;62035.6898215515;56085;56761.14858277129;57576.71211643915;57667.42332576704;58348.70825645845;37964.43053354202;48636.75681621569;48955.510444895095;49940.50059499359;50808;10329.173666106844;10495.632652857419;10509.579616815548;10916.399598022184;11097.833532497181;25364.492710146063;25522.361940951625;25582.488350233263;26360.077397291003;26400.471990559698;29628.555571666875;29712.405751885275;30026;30184.5472317911;30351.39297213999;12913.612591622266;12940.741185176055;13081.869181308066;13212.273324967218;13257.337133143497;14569.708605828037;14751.967362284537;14769.630759231106;14869.776953345925;14879.92560037193;12442;12606.49574017029;12692.111552191258;12727.618171454871;12771.680707982003;13835.723285534032;13900.72198556003;14032.158070515801;14433.711325773216;14787.11277323364;13106.344682766014;13359.53241636538;13413.32933353348;13440.865591343962;13764.810854730618;9497.85753213716;9563.952180239054;9836.409815411098;10045.748856278651;10251.948740256252;10865.565377384815;11594.188406811441;11797;12002.279863208236;12030.09774266916 06:54:30 INFO - PID 3391 | __end_tp_report 06:54:30 INFO - PID 3391 | __start_cc_report 06:54:30 INFO - PID 3391 | _x_x_mozilla_cycle_collect,1669 06:54:30 INFO - PID 3391 | __end_cc_report 06:54:30 INFO - PID 3391 | __startTimestamp1494597270148__endTimestamp 06:54:30 INFO - PID 3391 | 06:54:30 INFO - PID 3391 | ------- Summary: start ------- 06:54:30 INFO - PID 3391 | Number of tests: 6 06:54:30 INFO - PID 3391 | 06:54:30 INFO - PID 3391 | [#0] dojo.html Cycles:165 Average:5054.00 Median:5168.90 stddev:588.11 (11.4%) stddev-sans-first:559.37 06:54:30 INFO - PID 3391 | Values: 2669.4 2670.8 2702.7 2705.4 2710.8 5063.4 5140.4 5168.9 5178.6 5217.1 5055.8 5091.9 5103.5 5147.8 5163.7 4259.4 4512.3 4543.1 4618.2 4636.4 4560.7 4600.9 4628.0 4646.4 4660.0 4501.4 4535.4 4567.5 4581.6 4604.6 4564.7 4567.5 4608.1 4611.4 4631.4 4504.1 4536.8 4540.5 4559.1 4604.3 5044.4 5113.3 5116.8 5117.7 5120.7 5507.6 5518.1 5520.0 5521.2 5530.4 5512.1 5529.7 5536.3 5538.3 5540.8 5096.6 5148.2 5148.3 5158.1 5158.8 5627.2 5632.8 5667.8 5669.5 5678.8 5442.5 5449.2 5476.8 5486.8 5496.8 5530.2 5534.6 5538.5 5540.3 5546.3 5425.6 5483.0 5497.7 5504.9 5544.4 5470.4 5482.9 5483.0 5495.3 5498.4 4611.9 4679.8 4716.3 4717.9 4718.5 3993.1 4005.5 4014.1 4014.8 4044.7 4681.5 4684.3 4685.9 4733.5 4734.9 5487.3 5547.3 5553.0 5555.6 5598.9 4703.6 4710.8 4713.2 4715.2 4718.2 4970.1 4971.8 4972.4 4976.1 4977.3 4485.0 5036.7 5100.1 5102.6 5148.8 5502.6 5573.1 5578.2 5592.8 5624.9 5048.8 5085.7 5128.2 5129.2 5137.7 5449.6 5453.9 5459.6 5460.0 5470.2 5486.8 5547.3 5556.2 5580.7 5605.5 5340.3 5368.0 5427.6 5435.6 5453.8 5393.6 5400.4 5405.1 5409.0 5409.3 5317.5 5318.5 5327.5 5328.9 5377.8 5276.5 5309.3 5399.8 5406.5 5410.8 5174.4 5211.5 5222.9 5275.5 5302.5 06:54:30 INFO - PID 3391 | 06:54:30 INFO - PID 3391 | [#1] ext.html Cycles:180 Average:28610.98 Median:16857.03 stddev:36386.94 (215.9%) stddev-sans-first:36428.39 06:54:30 INFO - PID 3391 | Values: 640.2 697.9 716.5 995.1 1014.5 25969.7 30524.7 33416.8 33519.3 33533.8 35050.3 35437.3 35466.6 35478.5 35486.8 5203.6 6805.2 6958.9 6960.5 6963.0 5270.6 6630.8 6755.4 6756.5 6810.0 6786.5 6845.9 6848.8 6856.4 6856.8 5194.9 6762.6 6814.5 6816.3 6877.7 5058.2 6731.7 6878.7 6880.7 6884.3 30985.0 31445.0 31558.4 31600.7 31615.2 3027.7 3069.1 3071.6 3073.0 3073.8 24050.5 24082.4 24111.8 24137.0 24143.0 3190.0 3207.4 3216.6 3227.4 3227.5 131891.3 132427.3 132533.0 132548.0 132760.0 39769.2 39810.0 39861.0 39877.8 39892.6 41700.6 41720.4 41759.6 41853.6 41862.6 13115.3 13177.7 13181.1 13204.5 13218.5 8261.8 8427.6 10703.3 10769.3 10779.8 11354.7 11509.5 11533.8 11693.2 11702.9 4832.3 4886.0 4892.2 4895.4 4899.6 893.3 897.0 910.1 922.8 933.8 20613.9 20667.4 21145.9 21257.3 21404.4 957.8 968.0 973.8 990.2 997.8 10746.3 11145.7 11238.5 11270.7 11362.4 151663.0 151710.0 152350.0 152635.2 153806.2 39689.6 39792.4 39817.4 39835.2 39860.4 1186.9 1220.0 1222.9 1225.7 1230.6 19735.5 19751.4 19979.7 20872.7 21233.2 29216.4 29250.6 29261.4 29285.7 29287.1 137484.3 137601.0 137733.3 138313.0 139354.0 28661.1 28706.9 28710.6 28875.3 29730.3 36031.3 36122.8 36209.3 36367.3 36659.3 25934.2 27725.6 27842.7 28427.4 28575.9 27163.9 27424.9 27873.6 28044.3 28831.4 29459.7 30001.0 30395.0 30645.0 30823.4 26191.7 26249.9 26391.3 26921.3 27928.3 20319.3 21380.6 21552.7 21639.7 21682.0 06:54:30 INFO - PID 3391 | 06:54:30 INFO - PID 3391 | [#2] jquery.html Cycles:180 Average:24133.19 Median:36804.36 stddev:57369.24 (155.9%) stddev-sans-first:57502.45 06:54:30 INFO - PID 3391 | Values: 378.3 405.1 407.4 418.0 423.4 11434.3 13010.9 16999.5 17119.0 17137.7 18959.1 18959.3 19264.4 19374.7 19511.0 5551.8 5701.6 5706.5 5711.5 5723.4 3948.2 5661.4 5697.9 5700.4 5701.5 5538.8 5650.1 5663.2 5665.1 5678.1 5601.4 5687.4 5697.0 5697.7 5701.0 5044.2 5113.0 5134.5 5149.3 5152.9 21668.3 22207.7 22295.1 22447.0 22785.2 1596.1 1630.4 1633.1 1634.7 1636.8 13981.5 14751.9 14826.0 14860.1 14891.5 2038.5 2041.1 2052.8 2075.9 2086.9 72233.6 87347.6 87979.6 89398.0 92709.0 10589.3 10597.0 10871.5 11190.9 11431.3 14872.6 14893.6 14902.2 14997.4 15011.1 7447.2 7605.3 7695.9 7775.3 7869.9 7058.0 7075.7 7141.2 7300.9 7352.4 6834.8 6901.1 6908.9 6980.4 6985.7 1991.3 2038.3 2054.5 2079.6 2233.2 841.5 867.8 871.8 873.2 899.7 16689.2 17018.4 17197.7 17244.0 17732.4 888.1 888.4 888.5 888.6 908.6 9247.3 9620.0 9665.1 9727.7 9762.2 337506.0 341719.0 342343.0 347072.0 347324.0 78286.0 78559.0 79229.2 79505.8 80484.0 1067.7 1074.8 1122.6 1124.3 1126.5 16630.6 17449.9 17818.7 18158.5 18521.7 36335.3 37273.4 38373.0 38594.4 39655.2 47995.3 48017.3 48042.5 48076.8 50668.2 8311.2 8403.1 8566.4 8592.9 8920.3 12585.3 12817.0 12881.4 12949.5 13143.0 10676.6 11099.8 11242.7 11595.6 11630.9 10320.6 10559.8 10651.1 10856.7 10877.8 10925.7 10964.2 11356.8 11400.9 11414.9 8324.8 8401.9 8579.3 8633.3 8699.5 10426.0 10588.7 10877.3 11080.3 11169.4 06:54:30 INFO - PID 3391 | 06:54:30 INFO - PID 3391 | [#3] mootools.html Cycles:180 Average:6396.49 Median:3755.87 stddev:4135.02 (110.1%) stddev-sans-first:4128.51 06:54:30 INFO - PID 3391 | Values: 1245.9 1284.7 1292.6 1299.3 1301.9 9908.0 10266.2 10314.9 10342.5 10352.9 10112.6 10139.8 10588.6 10673.4 10688.0 2227.5 2267.3 2271.0 2271.4 2271.9 2157.6 2277.7 2280.3 2281.4 2285.4 1755.2 1820.7 1822.7 1826.1 1828.1 1981.1 2161.6 2319.3 2324.4 2327.3 2266.7 2304.0 2308.8 2311.6 2317.1 9941.6 10059.2 10068.0 10092.8 10108.3 4892.5 5072.5 5079.2 5086.4 5087.8 3294.8 3437.1 3441.8 3453.4 3466.8 1026.8 1081.9 1094.8 1107.3 1117.7 14805.3 15132.8 15133.1 15136.2 15139.2 5050.8 5231.9 5235.1 5273.0 5273.6 12740.0 12748.5 12749.6 12749.9 12763.6 5871.9 5881.9 5883.6 5884.3 5887.0 5066.6 5202.8 5248.7 5251.9 5273.0 4184.6 4283.9 4326.8 4331.8 4340.4 1288.9 1317.8 1328.2 1341.9 1348.8 684.9 706.0 708.7 726.7 729.2 5305.6 5360.8 5416.1 5419.4 5477.9 515.3 526.8 528.0 528.5 530.3 3524.8 3711.1 3737.2 3774.5 4008.9 13079.5 13295.6 13398.7 13419.4 13476.5 12862.7 13302.9 13304.1 13329.6 13339.5 7475.7 7672.5 7687.7 7690.0 7696.3 5899.3 6108.2 6195.8 6325.3 6344.0 11612.6 11864.7 11866.3 12014.5 12029.2 12245.1 12288.1 12464.0 12465.7 12487.6 8012.8 8188.1 8201.7 8360.4 8530.3 9861.0 9925.5 9948.0 9955.0 9959.7 8176.8 8185.0 8225.5 8301.9 8419.9 8103.4 8248.6 8256.5 8320.5 8480.0 7552.2 7590.7 7623.4 7641.2 7689.0 4439.4 5375.4 5406.5 5419.1 5681.9 5281.0 5432.0 5442.9 5463.6 5712.3 06:54:30 INFO - PID 3391 | 06:54:30 INFO - PID 3391 | [#4] prototype.html Cycles:180 Average:4551.71 Median:5221.67 stddev:1351.24 (25.9%) stddev-sans-first:1318.00 06:54:30 INFO - PID 3391 | Values: 365.9 382.3 384.4 390.6 391.4 5313.5 5331.2 5343.9 5383.8 5398.5 5043.5 5204.2 5209.9 5216.9 5229.2 3964.3 3972.5 3985.7 3993.9 4000.1 3965.6 3977.7 3978.5 3982.2 3997.9 3771.3 3907.2 3930.9 3942.1 3952.8 3882.3 3914.7 3921.4 3926.5 3928.9 3436.9 3443.2 3454.7 3455.2 3456.6 5021.9 5097.0 5150.6 5156.6 5166.9 4593.4 4597.8 4604.1 4629.2 4641.2 5491.3 5491.8 5506.2 5508.4 5517.8 3769.3 3837.8 3847.1 3853.8 3862.1 5539.9 5649.7 5690.8 5708.9 5838.5 3924.7 3932.4 3934.0 3944.3 3952.3 3980.7 3988.9 3990.4 3993.1 4003.8 4393.9 4488.3 4495.3 4560.8 4561.3 5532.8 5534.7 5541.7 5544.9 5553.4 1367.4 1367.9 1375.3 1377.5 1379.4 918.4 918.5 920.0 922.0 923.1 4829.9 4833.8 4836.3 4842.9 4865.2 5753.7 5759.7 5780.6 5781.8 5783.5 4707.6 4766.9 4774.0 4799.9 4842.5 2995.4 3014.2 3019.3 3027.8 3035.7 5195.3 5263.8 5269.7 5317.9 5321.5 5800.9 5843.6 5851.3 5857.7 5859.7 5268.2 5292.4 5299.4 5302.4 5304.8 5508.7 5690.5 5719.8 5753.7 5760.2 5365.8 5639.7 5640.7 5661.7 5666.8 5098.4 5226.4 5299.5 5302.4 5314.7 3941.0 3944.2 3946.6 3952.3 3952.8 5610.2 5738.8 5739.2 5779.7 5795.1 5555.1 5574.3 5576.2 5577.8 5586.9 5545.1 5575.5 5583.7 5587.4 5615.8 5250.8 5447.0 5488.2 5528.3 5543.6 5615.4 5620.9 5622.3 5629.4 5635.7 5372.9 5440.4 5444.9 5449.9 5467.2 06:54:30 INFO - PID 3391 | 06:54:30 INFO - PID 3391 | [#5] yui.html Cycles:180 Average:14868.64 Median:3150.24 stddev:17535.31 (556.6%) stddev-sans-first:17551.99 06:54:30 INFO - PID 3391 | Values: 650.4 671.8 731.8 744.8 768.7 13554.7 14035.1 14054.1 14066.9 14170.8 13556.4 15634.5 15681.8 15848.4 15869.1 869.3 889.4 889.5 889.7 893.8 898.2 901.7 902.3 902.4 902.5 925.4 925.5 925.8 926.3 926.4 920.7 927.7 929.2 935.0 939.2 666.8 667.5 673.0 675.0 688.5 14367.8 14397.2 14571.5 14572.6 14600.3 15310.5 15408.5 15724.4 15741.6 15747.4 12307.8 12492.9 12530.1 12531.6 12546.2 2953.6 2981.0 3012.4 3035.0 3042.5 69413.0 70555.3 70749.6 71647.3 71901.2 11480.0 11685.2 11798.8 12325.3 12575.9 21573.0 21995.3 22027.3 22136.6 22788.4 6138.7 6242.9 6254.3 6257.1 6261.3 3017.2 3096.2 3124.8 3150.1 3150.4 3547.2 3586.6 3588.9 3622.9 3624.7 716.3 732.8 745.8 752.6 754.1 573.4 582.2 592.1 596.6 604.6 9038.6 9433.7 9614.5 9732.4 9753.5 590.8 596.7 599.7 605.6 621.6 4518.8 4546.5 4566.5 4573.8 4597.2 59301.4 60375.0 60999.4 61510.7 62035.7 56085.0 56761.1 57576.7 57667.4 58348.7 37964.4 48636.8 48955.5 49940.5 50808.0 10329.2 10495.6 10509.6 10916.4 11097.8 25364.5 25522.4 25582.5 26360.1 26400.5 29628.6 29712.4 30026.0 30184.5 30351.4 12913.6 12940.7 13081.9 13212.3 13257.3 14569.7 14752.0 14769.6 14869.8 14879.9 12442.0 12606.5 12692.1 12727.6 12771.7 13835.7 13900.7 14032.2 14433.7 14787.1 13106.3 13359.5 13413.3 13440.9 13764.8 9497.9 9564.0 9836.4 10045.7 10251.9 10865.6 11594.2 11797.0 12002.3 12030.1 06:54:30 INFO - PID 3391 | -------- Summary: end -------- 06:54:30 INFO - PID 3391 | 06:54:31 INFO - TEST-INFO | 3391: exit 0 06:54:31 INFO - TEST-OK | dromaeo_css | took 1122936ms 06:54:31 INFO - TEST-START | kraken 06:54:31 INFO - operating with platform_type : linux_ 06:54:31 INFO - Initialising browser for kraken test... 06:54:31 INFO - TEST-INFO | started process 3718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbEQEtM/profile http://localhost:48624/getInfo.html) 06:54:35 INFO - PID 3718 | __metrics Screen width/height:1600/1200 06:54:35 INFO - PID 3718 | colorDepth:24 06:54:35 INFO - PID 3718 | Browser inner width/height: 1024/695 06:54:35 INFO - PID 3718 | __metrics 06:54:36 INFO - PID 3718 | 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" 06:54:36 INFO - PID 3718 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:54:37 INFO - TEST-INFO | 3718: exit 0 06:54:37 INFO - Browser initialized. 06:54:37 INFO - Running cycle 1/1 for kraken test... 06:54:37 INFO - TEST-INFO | started process 3814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbEQEtM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:54:49 INFO - PID 3814 | RSS: Main: 148840448 06:54:49 INFO - PID 3814 | 06:54:51 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48624/tests/kraken/driver.html?testName=audio-beat-detection) 06:54:52 INFO - PID 3814 | RSS: Main: 220897280 06:54:52 INFO - PID 3814 | 06:54:55 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48624/tests/kraken/driver.html?testName=audio-dft) 06:54:55 INFO - PID 3814 | RSS: Main: 182411264 06:54:55 INFO - PID 3814 | 06:54:58 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48624/tests/kraken/driver.html?testName=audio-fft) 06:54:59 INFO - PID 3814 | RSS: Main: 265142272 06:54:59 INFO - PID 3814 | 06:55:01 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48624/tests/kraken/driver.html?testName=audio-oscillator) 06:55:02 INFO - PID 3814 | RSS: Main: 176975872 06:55:02 INFO - PID 3814 | 06:55:04 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48624/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:55:05 INFO - PID 3814 | RSS: Main: 178987008 06:55:05 INFO - PID 3814 | 06:55:08 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48624/tests/kraken/driver.html?testName=imaging-darkroom) 06:55:08 INFO - PID 3814 | RSS: Main: 239292416 06:55:08 INFO - PID 3814 | 06:55:12 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48624/tests/kraken/driver.html?testName=imaging-desaturate) 06:55:12 INFO - PID 3814 | RSS: Main: 239124480 06:55:12 INFO - PID 3814 | 06:55:15 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48624/tests/kraken/driver.html?testName=json-parse-financial) 06:55:16 INFO - PID 3814 | RSS: Main: 236306432 06:55:16 INFO - PID 3814 | 06:55:18 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48624/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:55:18 INFO - PID 3814 | RSS: Main: 201342976 06:55:18 INFO - PID 3814 | 06:55:20 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:55:21 INFO - PID 3814 | RSS: Main: 188112896 06:55:21 INFO - PID 3814 | 06:55:23 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:55:23 INFO - PID 3814 | RSS: Main: 215552000 06:55:23 INFO - PID 3814 | 06:55:26 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:55:27 INFO - PID 3814 | RSS: Main: 225542144 06:55:27 INFO - PID 3814 | 06:55:30 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:55:31 INFO - PID 3814 | RSS: Main: 220983296 06:55:31 INFO - PID 3814 | 06:55:32 INFO - PID 3814 | Cycle 1(1): loaded http://localhost:48624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48624/tests/kraken/driver.html?testName=ai-astar) 06:55:33 INFO - PID 3814 | RSS: Main: 270626816 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | __start_tp_report 06:55:33 INFO - PID 3814 | _x_x_mozilla_page_load 06:55:33 INFO - PID 3814 | _x_x_mozilla_page_load_details 06:55:33 INFO - PID 3814 | |i|pagename|runs| 06:55:33 INFO - PID 3814 | |0;ai-astar;108;110;110;110;109;110;111;109;110;110 06:55:33 INFO - PID 3814 | |1;audio-beat-detection;154;124;124;166;124;128;121;121;141;121 06:55:33 INFO - PID 3814 | |2;audio-dft;163;161;160;160;161;161;161;161;163;162 06:55:33 INFO - PID 3814 | |3;audio-fft;74;75;75;120;75;76;76;74;95;78 06:55:33 INFO - PID 3814 | |4;audio-oscillator;84;83;108;83;82;83;96;83;83;110 06:55:33 INFO - PID 3814 | |5;imaging-gaussian-blur;114;114;114;114;114;113;113;113;115;114 06:55:33 INFO - PID 3814 | |6;imaging-darkroom;149;149;149;148;148;148;149;148;148;149 06:55:33 INFO - PID 3814 | |7;imaging-desaturate;94;94;94;93;93;94;93;93;94;93 06:55:33 INFO - PID 3814 | |8;json-parse-financial;55;56;55;54;56;57;56;56;56;56 06:55:33 INFO - PID 3814 | |9;json-stringify-tinderbox;56;56;55;55;55;55;56;56;56;55 06:55:33 INFO - PID 3814 | |10;stanford-crypto-aes;84;84;82;84;82;82;84;82;82;82 06:55:33 INFO - PID 3814 | |11;stanford-crypto-ccm;134;137;141;133;135;131;133;132;179;144 06:55:33 INFO - PID 3814 | |12;stanford-crypto-pbkdf2;197;199;199;201;199;196;200;202;197;199 06:55:33 INFO - PID 3814 | |13;stanford-crypto-sha256-iterative;76;75;73;74;72;73;72;73;71;72 06:55:33 INFO - PID 3814 | __end_tp_report 06:55:33 INFO - PID 3814 | __start_cc_report 06:55:33 INFO - PID 3814 | _x_x_mozilla_cycle_collect,2003 06:55:33 INFO - PID 3814 | __end_cc_report 06:55:33 INFO - PID 3814 | __startTimestamp1494597333194__endTimestamp 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | ------- Summary: start ------- 06:55:33 INFO - PID 3814 | Number of tests: 14 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.60 06:55:33 INFO - PID 3814 | Values: 108.0 110.0 110.0 110.0 109.0 110.0 111.0 109.0 110.0 110.0 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:126.00 stddev:15.95 (12.7%) stddev-sans-first:14.88 06:55:33 INFO - PID 3814 | Values: 154.0 124.0 124.0 166.0 124.0 128.0 121.0 121.0 141.0 121.0 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 06:55:33 INFO - PID 3814 | Values: 163.0 161.0 160.0 160.0 161.0 161.0 161.0 161.0 163.0 162.0 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.50 stddev:14.82 (19.6%) stddev-sans-first:15.44 06:55:33 INFO - PID 3814 | Values: 74.0 75.0 75.0 120.0 75.0 76.0 76.0 74.0 95.0 78.0 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:83.00 stddev:11.07 (13.3%) stddev-sans-first:11.56 06:55:33 INFO - PID 3814 | Values: 84.0 83.0 108.0 83.0 82.0 83.0 96.0 83.0 83.0 110.0 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 06:55:33 INFO - PID 3814 | Values: 114.0 114.0 114.0 114.0 114.0 113.0 113.0 113.0 115.0 114.0 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 06:55:33 INFO - PID 3814 | Values: 149.0 149.0 149.0 148.0 148.0 148.0 149.0 148.0 148.0 149.0 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 06:55:33 INFO - PID 3814 | Values: 94.0 94.0 94.0 93.0 93.0 94.0 93.0 93.0 94.0 93.0 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 06:55:33 INFO - PID 3814 | Values: 55.0 56.0 55.0 54.0 56.0 57.0 56.0 56.0 56.0 56.0 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:56.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 06:55:33 INFO - PID 3814 | Values: 56.0 56.0 55.0 55.0 55.0 55.0 56.0 56.0 56.0 55.0 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.03 (1.2%) stddev-sans-first:1.00 06:55:33 INFO - PID 3814 | Values: 84.0 84.0 82.0 84.0 82.0 82.0 84.0 82.0 82.0 82.0 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:136.00 stddev:14.34 (10.5%) stddev-sans-first:15.05 06:55:33 INFO - PID 3814 | Values: 134.0 137.0 141.0 133.0 135.0 131.0 133.0 132.0 179.0 144.0 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.90 Median:199.00 stddev:1.85 (0.9%) stddev-sans-first:1.83 06:55:33 INFO - PID 3814 | Values: 197.0 199.0 199.0 201.0 199.0 196.0 200.0 202.0 197.0 199.0 06:55:33 INFO - PID 3814 | 06:55:33 INFO - PID 3814 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:73.00 stddev:1.52 (2.1%) stddev-sans-first:1.20 06:55:33 INFO - PID 3814 | Values: 76.0 75.0 73.0 74.0 72.0 73.0 72.0 73.0 71.0 72.0 06:55:33 INFO - PID 3814 | -------- Summary: end -------- 06:55:33 INFO - PID 3814 | 06:55:34 INFO - TEST-INFO | 3814: exit 0 06:55:34 INFO - TEST-OK | kraken | took 63325ms 06:55:34 INFO - SUITE-END | took 1186s 06:55:34 INFO - Completed test suite (00:19:46) 06:55:34 INFO - javascript benchmark 06:55:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6603.929955687749, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2669.4394177222784, 2670.8130430869833, 2702.689190743064, 2705.364239403741, 2710.769584585311, 5063.4177069637, 5140.43455219926, 5168.896622067566, 5178.637495375326, 5217.087009773293, 5055.772490237939, 5091.872703182432, 5103.515166059227, 5147.81982630608, 5163.7418129093485, 4259.446271984638, 4512.323151527265, 4543.091381723652, 4618.214903466419, 4636.3740894979255, 4560.749158796281, 4600.907981840344, 4627.953720462803, 4646.4191976003, 4659.976700116512, 4501.392312037866, 4535.365048893158, 4567.474740404863, 4581.61056310214, 4604.58558729716, 4564.748938808364, 4567.497575266718, 4608.101420223058, 4611.44662640482, 4631.397918270603, 4504.121696269229, 4536.818527258905, 4540.545945405466, 4559.110973360196, 4604.332371806069, 5044.369453818273, 5113.335266415343, 5116.820911268088, 5117.667351622133, 5120.692758434506, 5507.586930980193, 5518.144687573433, 5520.033994051065, 5521.171824226358, 5530.419305972895, 5512.090505066659, 5529.695866727328, 5536.307961504812, 5538.280023596906, 5540.833774986757, 5096.643234973516, 5148.150555158357, 5148.304978827885, 5158.071547121479, 5158.767855446439, 5627.21219029328, 5632.802851900164, 5667.801626943037, 5669.546436285087, 5678.77284908599, 5442.482964118402, 5449.155380915964, 5476.780928762884, 5486.780528778884, 5496.7526461309335, 5530.225768392428, 5534.640248383923, 5538.47384498472, 5540.252065971043, 5546.251256080458, 5425.647332923348, 5483.013057649661, 5497.670139791625, 5504.862378440491, 5544.362398324244, 5470.425605311465, 5482.91775623366, 5483.0, 5495.34055913285, 5498.422665620133, 4611.930821037688, 4679.836205732851, 4716.292556116541, 4717.905641887143, 4718.528147185254, 3993.0616305168264, 4005.4592629994577, 4014.1369605534364, 4014.759114453142, 4044.716869819143, 4681.50844161365, 4684.273937539687, 4685.8594242172785, 4733.502982186821, 4734.928976065362, 5487.286652735199, 5547.33431988164, 5553.0, 5555.583331250092, 5598.944010559842, 4703.64722645803, 4710.81156753726, 4713.151632706145, 4715.151272770866, 4718.150732868048, 4970.105381031377, 4971.801127954914, 4972.378452693413, 4976.104301225814, 4977.253411988231, 4484.977575112103, 5036.672616280003, 5100.056489549445, 5102.566281866083, 5148.845534633967, 5502.58730595215, 5573.052581061311, 5578.163275508706, 5592.804251851166, 5624.943750562442, 5048.848534543969, 5085.7457127144235, 5128.153854614096, 5129.179331306973, 5137.717425541631, 5449.64577302474, 5453.863653408696, 5459.617826752089, 5460.0, 5470.17947307907, 5486.753096110764, 5547.33431988164, 5556.249906262765, 5580.665160090408, 5605.523530499953, 5340.279062326536, 5368.0, 5427.592930530305, 5435.619506634655, 5453.7818487260065, 5393.595480339069, 5400.351957765093, 5405.054115529845, 5409.0, 5409.269748583891, 5317.548008419173, 5318.547923426398, 5327.467253274796, 5328.946710532845, 5377.838664840061, 5276.472352764847, 5309.309789727311, 5399.78400863961, 5406.540444062299, 5410.810621628224, 5174.353205849269, 5211.4527974562125, 5222.895542089061, 5275.498827611371, 5302.522772950453], "value": 5012.003122612444, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.2477089419933, 697.8988046733224, 716.5449939288552, 995.1143482300749, 1014.4674046125788, 25969.74030259697, 30524.694753052463, 33416.832915835446, 33519.32961340775, 33533.83233083831, 35050.29899402011, 35437.2912541749, 35466.64533354666, 35478.467822982675, 35486.82256588714, 5203.557697595709, 6805.217399999002, 6958.8956165657555, 6960.547564408323, 6963.0, 5270.5520030797425, 6630.8010759677045, 6755.425788807957, 6756.49326300527, 6810.0, 6786.457083433338, 6845.931540684604, 6848.794536163899, 6856.41720453762, 6856.760013399532, 5194.948050519484, 6762.560433571826, 6814.52298339114, 6816.250212476623, 6877.690503927335, 5058.215976523645, 6731.697073631698, 6878.69045892936, 6880.69036893341, 6884.311568843125, 30985.0, 31445.0, 31558.368832623448, 31600.683993160004, 31615.20961975946, 3027.6518200407013, 3069.0639354996715, 3071.6467606225347, 3072.9846350768103, 3073.8155710657434, 24050.518989620283, 24082.397940051465, 24111.758882411126, 24137.0, 24143.0, 3190.0429871038596, 3207.4386982278243, 3216.6300875399393, 3227.402930457873, 3227.5158726191257, 131891.34054329764, 132427.33786331103, 132533.0, 132548.0, 132760.0, 39769.20461590752, 39810.0, 39861.0, 39877.80061099676, 39892.60107398889, 41700.582994170276, 41720.37419438711, 41759.58240417617, 41853.55903732556, 41862.58137418648, 13115.344232788513, 13177.670558236121, 13181.143225690299, 13204.537841175705, 13218.471261149447, 8261.83476330482, 8427.578621068922, 10703.304285221435, 10769.299995500267, 10779.78440431187, 11354.659360219206, 11509.48207330672, 11533.826992595117, 11693.239939403911, 11702.88297117035, 4832.34763306949, 4885.975570122127, 4892.217245240816, 4895.412550493964, 4899.58353539946, 893.2942975049768, 897.0446474504631, 910.0899100899101, 922.760082378573, 933.8412469880137, 20613.896930515253, 20667.379978600668, 21145.894270528548, 21257.255996040065, 21404.357869263946, 957.8323793336277, 967.9758006049905, 973.8149751547184, 990.1633120013577, 997.755549890267, 10746.301490403099, 11145.721356965978, 11238.494267757971, 11270.661880143609, 11362.375069371099, 151663.0, 151710.0, 152350.0, 152635.23682381518, 153806.23096884444, 39689.603103969166, 39792.40311395331, 39817.40273895894, 39835.20329593392, 39860.402093968616, 1186.8635106962638, 1219.9634010979685, 1222.9449674764658, 1225.724212052281, 1230.5693007447321, 19735.506612334808, 19751.40745777629, 19979.700304495153, 20872.68690969667, 21233.15067397287, 29216.415671686023, 29250.561241581818, 29261.414771704873, 29285.70714292915, 29287.12138635844, 137484.31257843648, 137601.0, 137733.3113334427, 138313.0, 139354.0, 28661.14016579506, 28706.856465718374, 28710.569341459475, 28875.278118047216, 29730.256743581584, 36031.27937441289, 36122.819385902905, 36209.27581448304, 36367.27265454729, 36659.266814663024, 25934.17569794751, 27725.584116237867, 27842.721572784012, 28427.43145137127, 28575.857120714263, 27163.86418067897, 27424.862875685492, 27873.58189627198, 28044.298892527033, 28831.423371532033, 29459.705402945696, 30001.0, 30395.0, 30645.0, 30823.383532329677, 26191.738082619693, 26249.868750656125, 26391.34021649474, 26921.326966825203, 27928.30179245535, 20319.288824891057, 21380.572388552453, 21552.676709849053, 21639.675404868623, 21682.0], "value": 14098.436173578615, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.334131927807, 405.10269752498226, 407.3929844531647, 417.95611460796613, 423.36706623597723, 11434.25677330973, 13010.869891301085, 16999.49001529953, 17119.0, 17137.65724685507, 18959.14683839227, 18959.33642322519, 19264.422067337968, 19374.70937935932, 19511.0, 5551.833444996657, 5701.572382071361, 5706.543476521868, 5711.485966263035, 5723.399043100477, 3948.190620922718, 5661.377248502661, 5697.914531282034, 5700.37295897451, 5701.515371193454, 5538.777934738655, 5650.124230744221, 5663.1505274208785, 5665.093585026397, 5678.119891416837, 5601.383847776741, 5687.431256874321, 5697.003024470701, 5697.715114244271, 5701.0, 5044.186475399612, 5113.0, 5134.486551344873, 5149.3305870237, 5152.871178220575, 21668.34994950154, 22207.66688499674, 22295.108195672154, 22446.98988545503, 22785.20251791179, 1596.1061805388904, 1630.4049022106847, 1633.0691505841676, 1634.7220972434714, 1636.8035835699793, 13981.483333000057, 14751.852481475154, 14826.0, 14860.108393496317, 14891.478798242119, 2038.5005673609912, 2041.1427200575645, 2052.8255098316663, 2075.8754474731563, 2086.926957556478, 72233.63883180551, 87347.56326218392, 87979.56010219971, 89397.99999999935, 92709.0, 10589.311694739818, 10597.0, 10871.45642717861, 11190.888091118984, 11431.314121152758, 14872.553823385315, 14893.553193404216, 14902.180380078982, 14997.400103995937, 15011.099334039993, 7447.218042105609, 7605.277498637621, 7695.923040769632, 7775.261350171724, 7869.881951770728, 7057.964710176519, 7075.71697132109, 7141.214466408691, 7300.853982920312, 7352.397325310666, 6834.829129271808, 6901.137357830271, 6908.9309106909295, 6980.371766541036, 6985.746878296514, 1991.3030439346112, 2038.3069756282935, 2054.4555692741437, 2079.5840831833393, 2233.1514024670846, 841.5287439034161, 867.8307729992591, 871.8387098386819, 873.2359185712502, 899.680613382253, 16689.24898379576, 17018.404355847484, 17197.65604687924, 17244.0, 17732.379366722103, 888.0808363343908, 888.4180861535705, 888.4891187567175, 888.6045709659139, 908.5502676175336, 9247.26021918245, 9620.0, 9665.081817227352, 9727.708168754949, 9762.170215531618, 337506.0, 341719.0, 342343.0, 347072.0, 347324.0, 78286.0, 78559.0, 79229.20770792218, 79505.80741288885, 80484.0, 1067.7117178361955, 1074.8280275156094, 1122.5565901469038, 1124.3197865291381, 1126.5043380912537, 16630.58423539373, 17449.912750436673, 17818.732719009484, 18158.546036348667, 18521.72217416767, 36335.27329453449, 37273.440898386005, 38373.0, 38594.42108368433, 39655.206895861345, 47995.28007079827, 48017.27974080322, 48042.5195748038, 48076.7596162031, 50668.23997640112, 8311.210435008665, 8403.117672644528, 8566.357523185661, 8592.871106933526, 8920.330975177018, 12585.307808070644, 12817.0, 12881.355932203165, 12949.54676586315, 13143.0, 10676.62631807883, 11099.778004439704, 11242.66272011841, 11595.5941542049, 11630.88369116298, 10320.587176512856, 10559.78880422372, 10651.147908167482, 10856.674299771019, 10877.836832447678, 10925.726856828325, 10964.232503724663, 11356.772864542829, 11400.94299528497, 11414.94292528532, 8324.83350333002, 8401.915980840113, 8579.2707619853, 8633.30933525304, 8699.521526316114, 10426.0, 10588.735281618021, 10877.347359158475, 11080.335179889233, 11169.441527923409], "value": 8852.037893617815, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1245.9314737689426, 1284.6980959474522, 1292.5669900583307, 1299.3178581244852, 1301.9218846869182, 9907.950460247697, 10266.230032747537, 10314.896851031488, 10342.482875856205, 10352.948235258831, 10112.646057387992, 10139.847902281472, 10588.576456941713, 10673.412962287071, 10688.0, 2227.543353612514, 2267.2744721689064, 2271.046160612547, 2271.4434963433982, 2271.9091236350528, 2157.611629906616, 2277.703898493202, 2280.270313499681, 2281.441046943501, 2285.394370491821, 1755.1750677181703, 1820.6813807583685, 1822.7174787907895, 1826.141713394709, 1828.076821205296, 1981.1382048808741, 2161.6325224711836, 2319.2810228829117, 2324.4421338878715, 2327.336709037933, 2266.7393249776324, 2304.043821813945, 2308.7575804540447, 2311.5954707926044, 2317.119494592061, 9941.552630131662, 10059.245556583286, 10068.04353586408, 10092.798144037151, 10108.292419530635, 4892.486288939681, 5072.51811077947, 5079.187330027178, 5086.389633243997, 5087.771050302708, 3294.769366144371, 3437.071990562534, 3441.776284541497, 3453.4129198036394, 3466.791992480459, 1026.7741096958657, 1081.8701755789355, 1094.8357746338033, 1107.2526044919728, 1117.7149826794116, 14805.333759980718, 15132.773008404993, 15133.092014479056, 15136.167510787012, 15139.243037848064, 5050.84847454577, 5231.947680523146, 5235.05768961583, 5272.9736351318, 5273.551748101378, 12740.0, 12748.490060397666, 12749.553765618159, 12749.872501275055, 12763.553275635308, 5871.941280587225, 5881.852953676193, 5883.588148829626, 5884.293884733859, 5886.970565147147, 5066.569341605931, 5202.817901373433, 5248.711320877312, 5251.868703282448, 5273.0, 4184.581541845791, 4283.871483855427, 4326.826926922888, 4331.848385306499, 4340.414044104069, 1288.884000439965, 1317.762802695505, 1328.2163523520976, 1341.9329033548283, 1348.8179095822134, 684.9315068493211, 705.992940070603, 708.6988030087192, 726.6621021225155, 729.234303980818, 5305.602079844027, 5360.812371566976, 5416.0521908666615, 5419.403865574784, 5477.863053423616, 515.317204703769, 526.8419474157737, 527.9894402111936, 528.4583302115286, 530.3158924986801, 3524.7708898922, 3711.1278849470355, 3737.1965027519213, 3774.5470543534952, 4008.9198216036098, 13079.476820927246, 13295.601131966056, 13398.732025359439, 13419.396127174301, 13476.5283215087, 12862.678433039062, 13302.866971330162, 13304.135231210133, 13329.600111996462, 13339.466421343037, 7475.70097196117, 7672.4629275951265, 7687.692492300357, 7689.999999999888, 7696.307332340004, 5899.321578018583, 6108.205933228652, 6195.81412557624, 6325.272593651789, 6343.9682801585695, 11612.593559225386, 11864.703382415508, 11866.347350895783, 12014.519419223483, 12029.15795894314, 12245.14284000147, 12288.078394120297, 12464.0, 12465.688357791129, 12487.625371238513, 8012.759617211493, 8188.058373287148, 8201.671933122609, 8360.414770966217, 8530.274926631306, 9860.950695246765, 9925.454100024279, 9948.0, 9954.950225248827, 9959.651412200828, 8176.7955801105445, 8184.959075204586, 8225.547594882339, 8301.875471868048, 8419.915800841913, 8103.392245581487, 8248.628811703607, 8256.463329883538, 8320.50076995358, 8479.95760021196, 7552.207018263003, 7590.658420371207, 7623.352015078781, 7641.235876412315, 7688.961555192188, 4439.4228750263555, 5375.4087050425205, 5406.486383793534, 5419.132938729785, 5681.863627274479, 5281.0, 5432.0, 5442.918356224739, 5463.562914966873, 5712.257406537124], "value": 4758.245694373731, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.90669379308275, 382.2660491855637, 384.39265959783546, 390.5645205595762, 391.41483482194104, 5313.548348390386, 5331.2003199519995, 5343.946560534394, 5383.811566595175, 5398.4601539846, 5043.495650434955, 5204.219367094937, 5209.86975325617, 5216.9478305216935, 5229.2156176573435, 3964.2864284428933, 3972.483577134976, 3985.720999530034, 3993.8602148924792, 4000.119973605802, 3965.583613720561, 3977.6618987385964, 3978.5225772907293, 3982.1836523512757, 3997.900052498682, 3771.321162190818, 3907.2185562887535, 3930.921381572381, 3942.073612701013, 3952.8221230044574, 3882.301185786557, 3914.6868250539887, 3921.3725803871384, 3926.4699265599065, 3928.941065884014, 3436.862525498977, 3443.1908501502126, 3454.6890779829937, 3455.1534873956043, 3456.6197718250974, 5021.874453138665, 5097.0, 5150.613703972217, 5156.613254005964, 5166.896662066738, 4593.44878614565, 4597.793099310539, 4604.125216208943, 4629.189891768927, 4641.234196357597, 5491.313585801775, 5491.807786727445, 5506.201600767866, 5508.366537848158, 5517.779288828442, 3769.2649933263024, 3837.7505462144873, 3847.1343947611845, 3853.8265778040054, 3862.053796819769, 5539.89483996083, 5649.723160566861, 5690.829275121753, 5708.942910570924, 5838.474537291621, 3924.6860251179837, 3932.390479475686, 3933.9606603934167, 3944.2703099926607, 3952.2688302663523, 3980.7014473914574, 3988.8831127284407, 3990.4413382126527, 3993.0616305168264, 4003.779792111462, 4393.934090988638, 4488.259437192892, 4495.348174514677, 4560.840370587013, 4561.29299958507, 5532.75102620375, 5534.667919924817, 5541.722913854291, 5544.91682624761, 5553.361363443256, 1367.3573420492353, 1367.9110857794212, 1375.3192169875977, 1377.5040985245303, 1379.379279324308, 918.3892711347013, 918.5499105438287, 919.995400023009, 921.9953900230456, 923.132255679659, 4829.850716431154, 4833.830815921426, 4836.250381190851, 4842.903141937141, 4865.172920603506, 5753.741081651252, 5759.712014399263, 5780.566457515703, 5781.797637082682, 5783.508401785811, 4707.552782485658, 4766.904661906812, 4773.9761301193275, 4799.856004319876, 4842.465000549548, 2995.400919816002, 3014.2464383904025, 3019.3206528531346, 3027.7729170312314, 3035.711607397294, 5195.3246078009615, 5263.815766448232, 5269.683818970874, 5317.867053323698, 5321.494458026481, 5800.9129863052085, 5843.5909486336395, 5851.268591426072, 5857.70711464425, 5859.736311865976, 5268.2361057647195, 5292.444293349143, 5299.364076310713, 5302.416734159317, 5304.761285742151, 5508.697021663686, 5690.544756419559, 5719.771209151754, 5753.683547404933, 5760.1935728998815, 5365.812196573102, 5639.731060511353, 5640.743702519026, 5661.688607126647, 5666.829995100154, 5098.41368242642, 5226.40076732473, 5299.549538289289, 5302.39022512416, 5314.734263286898, 3940.960590394059, 3944.1520073183256, 3946.58560851118, 3952.3281042222316, 3952.782596957195, 5610.186522954067, 5738.770449181986, 5739.167820665896, 5779.7110144493445, 5795.130730390307, 5555.111182210827, 5574.331080270394, 5576.163575463713, 5577.832665020056, 5586.916196256978, 5545.112781955029, 5575.526080283222, 5583.748731307182, 5587.413321601336, 5615.775368985195, 5250.842474725764, 5446.972765136149, 5488.17677348401, 5528.308961379827, 5543.556515478833, 5615.438456154516, 5620.943790562042, 5622.269105016322, 5629.437056294338, 5635.6618602883955, 5372.919406208988, 5440.374356949002, 5444.918326225031, 5449.918251226314, 5467.20725494809], "value": 4138.454896365353, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.3593959949446, 671.7783131566581, 731.7877815433521, 744.7542311037356, 768.7117331000875, 13554.728905421885, 14035.087719298239, 14054.086484378508, 14066.929665351672, 14170.787438188423, 13556.389962451689, 15634.530964071068, 15681.764773528406, 15848.3660653574, 15869.127198004106, 869.3002133282705, 889.4263200235844, 889.5196593839319, 889.6619284671816, 893.8033632600817, 898.1647068226547, 901.6799036342103, 902.2511315608062, 902.3593248793364, 902.512643172686, 925.3661242049184, 925.509479975614, 925.8379783537888, 926.2867591954191, 926.3654396738223, 920.7375897869109, 927.679950417105, 929.159111004542, 934.9719508414759, 939.1641439119189, 666.8132922781629, 667.4993754683987, 673.0375562944987, 674.9628770417625, 688.4526801193064, 14367.78448323276, 14397.20815355155, 14571.489997850025, 14572.562823115324, 14600.269986500738, 15310.464133755377, 15408.53774386759, 15724.449644262397, 15741.606459838482, 15747.448839290684, 12307.815382769177, 12492.875071249353, 12530.122891397607, 12531.624051278384, 12546.247225166428, 2953.616029916097, 2980.955285670717, 3012.3824615953895, 3035.04396115223, 3042.4827779277575, 69413.0, 70555.29444705539, 70749.64625176892, 71647.28352716459, 71901.20246993867, 11480.0, 11685.240459370114, 11798.764024719458, 12325.322107284006, 12575.93712031434, 21573.0, 21995.340139795833, 22027.33917982463, 22136.557268854856, 22788.43028924257, 6138.7237574309265, 6242.937570624235, 6254.312025677172, 6257.124002639634, 6261.279952805486, 3017.170278173476, 3096.210466331071, 3124.7500199983947, 3150.054983504939, 3150.417172823035, 3547.237343971007, 3586.5875424326537, 3588.9102772430897, 3622.945655815165, 3624.655657712513, 716.2944499667823, 732.802143421284, 745.8247311881703, 752.6086435053742, 754.1402800807084, 573.4122524412427, 582.2343618142214, 592.1413949772847, 596.6151832068292, 604.5707547641136, 9038.63845446188, 9433.669821556212, 9614.471204083702, 9732.36739611937, 9753.512324383752, 590.7961753195141, 596.7463827873137, 599.6821684507219, 605.6003037994902, 621.5711159300068, 4518.796654150571, 4546.522615125365, 4566.543345665407, 4573.839915602938, 4597.218472859622, 59301.40698593045, 60375.0, 60999.39000610026, 61510.69244653748, 62035.6898215515, 56085.0, 56761.14858277129, 57576.71211643915, 57667.42332576704, 58348.70825645845, 37964.43053354202, 48636.75681621569, 48955.510444895095, 49940.50059499359, 50808.0, 10329.173666106844, 10495.632652857419, 10509.579616815548, 10916.399598022184, 11097.833532497181, 25364.492710146063, 25522.361940951625, 25582.488350233263, 26360.077397291003, 26400.471990559698, 29628.555571666875, 29712.405751885275, 30026.0, 30184.5472317911, 30351.39297213999, 12913.612591622266, 12940.741185176055, 13081.869181308066, 13212.273324967218, 13257.337133143497, 14569.708605828037, 14751.967362284537, 14769.630759231106, 14869.776953345925, 14879.92560037193, 12442.0, 12606.49574017029, 12692.111552191258, 12727.618171454871, 12771.680707982003, 13835.723285534032, 13900.72198556003, 14032.158070515801, 14433.711325773216, 14787.11277323364, 13106.344682766014, 13359.53241636538, 13413.32933353348, 13440.865591343962, 13764.810854730618, 9497.85753213716, 9563.952180239054, 9836.409815411098, 10045.748856278651, 10251.948740256252, 10865.565377384815, 11594.188406811441, 11797.0, 12002.279863208236, 12030.09774266916], "value": 6733.974773754234, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 110.0, 110.0, 109.0, 110.0, 111.0, 109.0, 110.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 124.0, 166.0, 124.0, 128.0, 121.0, 121.0, 141.0, 121.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 163.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 120.0, 75.0, 76.0, 76.0, 74.0, 95.0, 78.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 108.0, 83.0, 82.0, 83.0, 96.0, 83.0, 83.0, 110.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 115.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 148.0, 148.0, 148.0, 149.0, 148.0, 148.0, 149.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 93.0, 93.0, 94.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 54.0, 56.0, 57.0, 56.0, 56.0, 56.0, 56.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 56.0, 56.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 82.0, 84.0, 82.0, 82.0, 84.0, 82.0, 82.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 137.0, 141.0, 133.0, 135.0, 131.0, 133.0, 132.0, 179.0, 144.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 199.0, 199.0, 201.0, 199.0, 196.0, 200.0, 202.0, 197.0, 199.0], "value": 198.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 73.0, 74.0, 72.0, 73.0, 72.0, 73.0, 71.0, 72.0], "value": 73.1, "unit": "score"}]}]} 06:55:34 INFO - Return code: 0 06:55:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:55:35 INFO - # TBPL SUCCESS # 06:55:35 INFO - Running post-action listener: _resource_record_post_action 06:55:35 INFO - [mozharness: 2017-05-12 13:55:35.009792Z] Finished run-tests step (success) 06:55:35 INFO - Running post-run listener: _resource_record_post_run 06:55:35 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 7839744; Write bytes: 368410624; Read time: 2092; Write time: 388048 06:55:35 INFO - TinderboxPrint: CPU usage
12.9% 06:55:35 INFO - TinderboxPrint: I/O read bytes / time
7,839,744 / 2,092 06:55:35 INFO - TinderboxPrint: I/O write bytes / time
368,410,624 / 388,048 06:55:35 INFO - TinderboxPrint: CPU idle
8,358.5 (87.0%) 06:55:35 INFO - TinderboxPrint: CPU user
1,196.7 (12.5%) 06:55:35 INFO - TinderboxPrint: Swap in / out
0 / 0 06:55:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 114642944; Read time: 16; Write time: 154956 06:55:35 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 5619712; Write bytes: 253767680; Read time: 1848; Write time: 233092 06:55:35 INFO - Running post-run listener: _upload_blobber_files 06:55:35 INFO - Blob upload gear active. 06:55:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:55:35 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 06:55:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:55:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:55:36 INFO - (blobuploader) - INFO - Open directory for files ... 06:55:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:55:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:55:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:55:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:55:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:55:39 INFO - (blobuploader) - INFO - Done attempting. 06:55:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:55:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:55:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:55:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:55:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:55:40 INFO - (blobuploader) - INFO - Done attempting. 06:55:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:55:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:55:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:55:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:55:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:55:43 INFO - (blobuploader) - INFO - Done attempting. 06:55:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:55:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:55:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:55:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:55:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:55:44 INFO - (blobuploader) - INFO - Done attempting. 06:55:44 INFO - (blobuploader) - INFO - Iteration through files over. 06:55:44 INFO - Return code: 0 06:55:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:55:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:55:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/298780efe84062a958f47eebc8b303b7bf5b9e33d9433a548bd3ad3d5748c5221866d372ecfad4057e35003a52193d076a6faa1d47cca969d89b8d281b6247d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2dca68bf9d1619b4bc44fe8208d4a812ff12554376f94fadc8cdb1f701443417649482ae470968f18b439b568e51abce4d74ce11a786ff9bdd661a9632149364", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3893a9467b01e0da1a4f5b24d7133aeb3888fe424c0d23211488b074d5d6074c6802a82124ccd41854a30639c35da97acdf984e7fc621515e26139d745d8f61", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d63299bcb37eb1210bfe4f40b545ee7a5344ae80fd1138966e6babb67ff699cb6afa9752b9a7eb662fca8c75de632a7431dc2025e37f25f33ff29500023c2e1"} 06:55:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:55:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:55:44 INFO - Contents: 06:55:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/298780efe84062a958f47eebc8b303b7bf5b9e33d9433a548bd3ad3d5748c5221866d372ecfad4057e35003a52193d076a6faa1d47cca969d89b8d281b6247d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2dca68bf9d1619b4bc44fe8208d4a812ff12554376f94fadc8cdb1f701443417649482ae470968f18b439b568e51abce4d74ce11a786ff9bdd661a9632149364", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3893a9467b01e0da1a4f5b24d7133aeb3888fe424c0d23211488b074d5d6074c6802a82124ccd41854a30639c35da97acdf984e7fc621515e26139d745d8f61", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d63299bcb37eb1210bfe4f40b545ee7a5344ae80fd1138966e6babb67ff699cb6afa9752b9a7eb662fca8c75de632a7431dc2025e37f25f33ff29500023c2e1"} 06:55:44 INFO - Running post-run listener: copy_logs_to_upload_dir 06:55:44 INFO - Copying logs to upload dir... 06:55:44 INFO - mkdir: /builds/slave/test/build/upload/logs 06:55:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.421866 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-05-12 06:55:44.057108) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 06:55:44.061988) ========= 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=fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628 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-Non-PGO/sha512/298780efe84062a958f47eebc8b303b7bf5b9e33d9433a548bd3ad3d5748c5221866d372ecfad4057e35003a52193d076a6faa1d47cca969d89b8d281b6247d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2dca68bf9d1619b4bc44fe8208d4a812ff12554376f94fadc8cdb1f701443417649482ae470968f18b439b568e51abce4d74ce11a786ff9bdd661a9632149364", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3893a9467b01e0da1a4f5b24d7133aeb3888fe424c0d23211488b074d5d6074c6802a82124ccd41854a30639c35da97acdf984e7fc621515e26139d745d8f61", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d63299bcb37eb1210bfe4f40b545ee7a5344ae80fd1138966e6babb67ff699cb6afa9752b9a7eb662fca8c75de632a7431dc2025e37f25f33ff29500023c2e1"} build_url:https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011012 build_url: 'https://queue.taskcluster.net/v1/task/VoXTNIBARVCpnHEkjQyyzw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/298780efe84062a958f47eebc8b303b7bf5b9e33d9433a548bd3ad3d5748c5221866d372ecfad4057e35003a52193d076a6faa1d47cca969d89b8d281b6247d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2dca68bf9d1619b4bc44fe8208d4a812ff12554376f94fadc8cdb1f701443417649482ae470968f18b439b568e51abce4d74ce11a786ff9bdd661a9632149364", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d3893a9467b01e0da1a4f5b24d7133aeb3888fe424c0d23211488b074d5d6074c6802a82124ccd41854a30639c35da97acdf984e7fc621515e26139d745d8f61", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d63299bcb37eb1210bfe4f40b545ee7a5344ae80fd1138966e6babb67ff699cb6afa9752b9a7eb662fca8c75de632a7431dc2025e37f25f33ff29500023c2e1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 06:55:44.086836) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:55:44.087155) ========= 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=fa44defc139c4ba8574fe040000001db-1494596079.513769-1889019628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:55:44.169361) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 06:55:44.172694) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 06:55:44.172987) ========= ========= Total master_lag: 0.19 =========