builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1481366143.27 results: success (0) buildid: 20161210014650 builduid: dc7df3cdb1894f7b9558873f6b29da3e revision: 9563f383566a5deb84d7b16e0f06426006b530f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:43.268754) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:43.269279) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:43.269619) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:43.285702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:43.286110) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-10 02:35:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.4M=0s 2016-12-10 02:35:43 (45.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115583 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:43.415188) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:43.415562) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016585 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:43.465231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:43.465634) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 9563f383566a5deb84d7b16e0f06426006b530f0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 9563f383566a5deb84d7b16e0f06426006b530f0 --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=7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-10 02:35:43,594 truncating revision to first 12 chars 2016-12-10 02:35:43,594 Setting DEBUG logging. 2016-12-10 02:35:43,594 attempt 1/10 2016-12-10 02:35:43,594 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/9563f383566a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-10 02:35:44,076 unpacking tar archive at: graphics-9563f383566a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.844188 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:44.325621) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:44.326170) ========= script_repo_revision: 9563f383566a5deb84d7b16e0f06426006b530f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:44.326827) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:44.327297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-10 02:35:44.344500) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-12-10 02:35:44.345124) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:35:44 INFO - MultiFileLogger online at 20161210 02:35:44 in /builds/slave/test 02:35:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 02:35:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:35:44 INFO - {'append_to_log': False, 02:35:44 INFO - 'base_work_dir': '/builds/slave/test', 02:35:44 INFO - 'blob_upload_branch': 'Graphics', 02:35:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:35:44 INFO - 'branch': 'Graphics', 02:35:44 INFO - 'buildbot_json_path': 'buildprops.json', 02:35:44 INFO - 'config_files': ('talos/linux_config.py',), 02:35:44 INFO - 'default_actions': ('clobber', 02:35:44 INFO - 'read-buildbot-config', 02:35:44 INFO - 'download-and-extract', 02:35:44 INFO - 'populate-webroot', 02:35:44 INFO - 'create-virtualenv', 02:35:44 INFO - 'install', 02:35:44 INFO - 'run-tests'), 02:35:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:35:44 INFO - 'download_minidump_stackwalk': True, 02:35:44 INFO - 'download_symbols': 'ondemand', 02:35:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:35:44 INFO - 'tooltool.py': '/tools/tooltool.py', 02:35:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:35:44 INFO - '/tools/misc-python/virtualenv.py')}, 02:35:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:35:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:35:44 INFO - 'installer_path': 'installer.exe', 02:35:44 INFO - 'log_level': 'info', 02:35:44 INFO - 'log_name': 'talos', 02:35:44 INFO - 'log_to_console': True, 02:35:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:35:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:35:44 INFO - 'opt_config_files': (), 02:35:44 INFO - 'pip_index': False, 02:35:44 INFO - 'sps_profile': False, 02:35:44 INFO - 'sps_profile_interval': 0, 02:35:44 INFO - 'suite': 'dromaeojs', 02:35:44 INFO - 'system_bits': '32', 02:35:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:35:44 INFO - 'title': 'talos-linux64-ix-005', 02:35:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:35:44 INFO - 'use_talos_json': True, 02:35:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:35:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:35:44 INFO - 'work_dir': 'build'} 02:35:44 INFO - [mozharness: 2016-12-10 10:35:44.572388Z] Running clobber step. 02:35:44 INFO - Running pre-action listener: _resource_record_pre_action 02:35:44 INFO - Running main action method: clobber 02:35:44 INFO - rmtree: /builds/slave/test/build 02:35:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:35:45 INFO - Running post-action listener: _resource_record_post_action 02:35:45 INFO - [mozharness: 2016-12-10 10:35:45.016688Z] Finished clobber step (success) 02:35:45 INFO - [mozharness: 2016-12-10 10:35:45.016786Z] Running read-buildbot-config step. 02:35:45 INFO - Running pre-action listener: _resource_record_pre_action 02:35:45 INFO - Running main action method: read_buildbot_config 02:35:45 INFO - Using buildbot properties: 02:35:45 INFO - { 02:35:45 INFO - "project": "", 02:35:45 INFO - "product": "firefox", 02:35:45 INFO - "script_repo_revision": "default", 02:35:45 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 02:35:45 INFO - "repository": "", 02:35:45 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 02:35:45 INFO - "buildid": "20161210014650", 02:35:45 INFO - "pgo_build": "False", 02:35:45 INFO - "basedir": "/builds/slave/test", 02:35:45 INFO - "buildnumber": 26, 02:35:45 INFO - "slavename": "talos-linux64-ix-005", 02:35:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:35:45 INFO - "platform": "ubuntu64_hw", 02:35:45 INFO - "scheduler": "tests-graphics-linux64-talos", 02:35:45 INFO - "branch": "graphics", 02:35:45 INFO - "repo_path": "projects/graphics", 02:35:45 INFO - "revision": "9563f383566a5deb84d7b16e0f06426006b530f0", 02:35:45 INFO - "stage_platform": "linux64", 02:35:45 INFO - "builduid": "dc7df3cdb1894f7b9558873f6b29da3e", 02:35:45 INFO - "slavebuilddir": "test" 02:35:45 INFO - } 02:35:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 02:35:45 INFO - Running post-action listener: _resource_record_post_action 02:35:45 INFO - [mozharness: 2016-12-10 10:35:45.019303Z] Finished read-buildbot-config step (success) 02:35:45 INFO - [mozharness: 2016-12-10 10:35:45.019390Z] Running download-and-extract step. 02:35:45 INFO - Running pre-action listener: _resource_record_pre_action 02:35:45 INFO - Running main action method: download_and_extract 02:35:45 INFO - mkdir: /builds/slave/test/build/tests 02:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:35:45 INFO - trying https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:35:45 INFO - Downloading https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:35:45 INFO - Downloaded 1361 bytes. 02:35:45 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 02:35:45 INFO - Using the following test package requirements: 02:35:45 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 02:35:45 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:35:45 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:35:45 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:45 INFO - u'jsshell-linux-x86_64.zip'], 02:35:45 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:35:45 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 02:35:45 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:35:45 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:35:45 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:35:45 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 02:35:45 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:35:45 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:35:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 02:35:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:35:45 INFO - Fetch https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:35:47 INFO - Expected file size: 20222327 02:35:47 INFO - Obtained file size: 20222327 02:35:51 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:35:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 02:35:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:35:51 INFO - Fetch https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:35:52 INFO - Expected file size: 20222327 02:35:52 INFO - Obtained file size: 20222327 02:35:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 02:35:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:35:56 INFO - Fetch https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:35:58 INFO - Expected file size: 14409734 02:35:58 INFO - Obtained file size: 14409734 02:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:35:58 INFO - trying https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:35:58 INFO - Downloading https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:36:00 INFO - Downloaded 55783690 bytes. 02:36:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:36:00 INFO - mkdir: /builds/slave/test/properties 02:36:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:36:00 INFO - Writing to file /builds/slave/test/properties/build_url 02:36:00 INFO - Contents: 02:36:00 INFO - build_url:https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 02:36:01 INFO - Running post-action listener: _resource_record_post_action 02:36:01 INFO - Running post-action listener: set_extra_try_arguments 02:36:01 INFO - [mozharness: 2016-12-10 10:36:01.255285Z] Finished download-and-extract step (success) 02:36:01 INFO - [mozharness: 2016-12-10 10:36:01.255511Z] Running populate-webroot step. 02:36:01 INFO - Running pre-action listener: _resource_record_pre_action 02:36:01 INFO - Running main action method: populate_webroot 02:36:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:36:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:36:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:36:01 INFO - '--tppagecycles', 02:36:01 INFO - '7'], 02:36:01 INFO - 'tests': ['tsvgm']}}, 02:36:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:36:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:36:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:36:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:36:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:36:01 INFO - 'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:36:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:36:01 INFO - 'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['damp', 'tps']}, 02:36:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:36:01 INFO - 'tests': ['damp', 'tps']}, 02:36:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['dromaeo_dom']}, 02:36:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:36:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['basic_compositor_video']}, 02:36:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:36:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['a11yr', 02:36:01 INFO - 'ts_paint', 02:36:01 INFO - 'tpaint', 02:36:01 INFO - 'sessionrestore', 02:36:01 INFO - 'sessionrestore_no_auto_restore', 02:36:01 INFO - 'tabpaint']}, 02:36:01 INFO - 'other-e10s': {'tests': ['a11yr', 02:36:01 INFO - 'ts_paint', 02:36:01 INFO - 'tpaint', 02:36:01 INFO - 'sessionrestore', 02:36:01 INFO - 'sessionrestore_no_auto_restore', 02:36:01 INFO - 'tabpaint']}, 02:36:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:36:01 INFO - 'ts_paint', 02:36:01 INFO - 'tpaint', 02:36:01 INFO - 'sessionrestore', 02:36:01 INFO - 'sessionrestore_no_auto_restore', 02:36:01 INFO - 'tabpaint']}, 02:36:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:36:01 INFO - 'ts_paint', 02:36:01 INFO - 'tpaint', 02:36:01 INFO - 'sessionrestore', 02:36:01 INFO - 'sessionrestore_no_auto_restore', 02:36:01 INFO - 'tabpaint']}, 02:36:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['a11yr', 02:36:01 INFO - 'ts_paint', 02:36:01 INFO - 'tpaint', 02:36:01 INFO - 'sessionrestore', 02:36:01 INFO - 'sessionrestore_no_auto_restore', 02:36:01 INFO - 'tabpaint']}, 02:36:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['a11yr', 02:36:01 INFO - 'ts_paint', 02:36:01 INFO - 'tpaint', 02:36:01 INFO - 'sessionrestore', 02:36:01 INFO - 'sessionrestore_no_auto_restore', 02:36:01 INFO - 'tabpaint']}, 02:36:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['tsvgx', 02:36:01 INFO - 'tsvgr_opacity', 02:36:01 INFO - 'tart', 02:36:01 INFO - 'tscrollx', 02:36:01 INFO - 'cart', 02:36:01 INFO - 'tsvg_static']}, 02:36:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:36:01 INFO - 'tsvgr_opacity', 02:36:01 INFO - 'tart', 02:36:01 INFO - 'tscrollx', 02:36:01 INFO - 'cart', 02:36:01 INFO - 'tsvg_static']}, 02:36:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:36:01 INFO - 'talos_options': ['--disable-e10s'], 02:36:01 INFO - 'tests': ['tp5o']}, 02:36:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:36:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:36:01 INFO - 'talos_options': ['--disable-e10s', 02:36:01 INFO - '--xperf_path', 02:36:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:01 INFO - 'tests': ['tp5n']}, 02:36:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:36:01 INFO - 'talos_options': ['--xperf_path', 02:36:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:01 INFO - 'tests': ['tp5n']}}, 02:36:01 INFO - 'talos.zip': {'path': '', 02:36:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:36:01 INFO - Running post-action listener: _resource_record_post_action 02:36:01 INFO - [mozharness: 2016-12-10 10:36:01.272171Z] Finished populate-webroot step (success) 02:36:01 INFO - [mozharness: 2016-12-10 10:36:01.272258Z] Running create-virtualenv step. 02:36:01 INFO - Running pre-action listener: _resource_record_pre_action 02:36:01 INFO - Running main action method: create_virtualenv 02:36:01 INFO - Creating virtualenv /builds/slave/test/build/venv 02:36:01 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 02:36:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:36:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:36:01 INFO - Using real prefix '/usr' 02:36:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:36:01 INFO - Installing distribute.............................................................................................................................................................................................done. 02:36:03 INFO - Installing pip.................done. 02:36:03 INFO - Return code: 0 02:36:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:36:04 INFO - Reading from file tmpfile_stdout 02:36:04 INFO - Output received: 02:36:04 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) 02:36:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:04 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f0451da8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaf20>, '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 0x2b57c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', '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 02:36:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:36:04 INFO - Using env: {'DISPLAY': ':0', 02:36:04 INFO - 'HOME': '/home/cltbld', 02:36:04 INFO - 'LANG': 'en_US.UTF-8', 02:36:04 INFO - 'LANGUAGE': 'en_US:en', 02:36:04 INFO - 'LOGNAME': 'cltbld', 02:36:04 INFO - 'MAIL': '/var/mail/cltbld', 02:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:04 INFO - 'MOZ_NO_REMOTE': '1', 02:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:04 INFO - 'NO_EM_RESTART': '1', 02:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:04 INFO - 'PWD': '/builds/slave/test', 02:36:04 INFO - 'SHELL': '/bin/bash', 02:36:04 INFO - 'SHLVL': '1', 02:36:04 INFO - 'TERM': 'linux', 02:36:04 INFO - 'TMOUT': '86400', 02:36:04 INFO - 'USER': 'cltbld', 02:36:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', 02:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:04 INFO - '_': '/tools/buildbot/bin/python'} 02:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:04 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 02:36:04 INFO - Cleaning up... 02:36:04 INFO - Return code: 0 02:36:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:04 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f0451da8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaf20>, '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 0x2b57c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', '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 02:36:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:36:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:36:04 INFO - Using env: {'DISPLAY': ':0', 02:36:04 INFO - 'HOME': '/home/cltbld', 02:36:04 INFO - 'LANG': 'en_US.UTF-8', 02:36:04 INFO - 'LANGUAGE': 'en_US:en', 02:36:04 INFO - 'LOGNAME': 'cltbld', 02:36:04 INFO - 'MAIL': '/var/mail/cltbld', 02:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:04 INFO - 'MOZ_NO_REMOTE': '1', 02:36:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:04 INFO - 'NO_EM_RESTART': '1', 02:36:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:04 INFO - 'PWD': '/builds/slave/test', 02:36:04 INFO - 'SHELL': '/bin/bash', 02:36:04 INFO - 'SHLVL': '1', 02:36:04 INFO - 'TERM': 'linux', 02:36:04 INFO - 'TMOUT': '86400', 02:36:04 INFO - 'USER': 'cltbld', 02:36:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', 02:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:04 INFO - '_': '/tools/buildbot/bin/python'} 02:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:04 INFO - Downloading/unpacking psutil>=3.1.1 02:36:04 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 02:36:04 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 02:36:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:04 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 02:36:04 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 02:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:36:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:06 INFO - Installing collected packages: psutil 02:36:06 INFO - Running setup.py install for psutil 02:36:06 INFO - building 'psutil._psutil_linux' extension 02:36:06 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 02:36:06 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 02:36:06 INFO - building 'psutil._psutil_posix' extension 02:36:06 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 02:36:06 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 02:36:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:07 INFO - Successfully installed psutil 02:36:07 INFO - Cleaning up... 02:36:07 INFO - Return code: 0 02:36:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:07 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f0451da8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaf20>, '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 0x2b57c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', '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 02:36:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:36:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:36:07 INFO - Using env: {'DISPLAY': ':0', 02:36:07 INFO - 'HOME': '/home/cltbld', 02:36:07 INFO - 'LANG': 'en_US.UTF-8', 02:36:07 INFO - 'LANGUAGE': 'en_US:en', 02:36:07 INFO - 'LOGNAME': 'cltbld', 02:36:07 INFO - 'MAIL': '/var/mail/cltbld', 02:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:07 INFO - 'MOZ_NO_REMOTE': '1', 02:36:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:07 INFO - 'NO_EM_RESTART': '1', 02:36:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:07 INFO - 'PWD': '/builds/slave/test', 02:36:07 INFO - 'SHELL': '/bin/bash', 02:36:07 INFO - 'SHLVL': '1', 02:36:07 INFO - 'TERM': 'linux', 02:36:07 INFO - 'TMOUT': '86400', 02:36:07 INFO - 'USER': 'cltbld', 02:36:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', 02:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:07 INFO - '_': '/tools/buildbot/bin/python'} 02:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:36:07 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 02:36:07 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 02:36:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:07 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 02:36:07 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 02:36:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:36:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:36:09 INFO - Installing collected packages: mozsystemmonitor 02:36:09 INFO - Running setup.py install for mozsystemmonitor 02:36:09 INFO - Successfully installed mozsystemmonitor 02:36:09 INFO - Cleaning up... 02:36:09 INFO - Return code: 0 02:36:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f0451da8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaf20>, '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 0x2b57c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', '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 02:36:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:36:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:36:09 INFO - Using env: {'DISPLAY': ':0', 02:36:09 INFO - 'HOME': '/home/cltbld', 02:36:09 INFO - 'LANG': 'en_US.UTF-8', 02:36:09 INFO - 'LANGUAGE': 'en_US:en', 02:36:09 INFO - 'LOGNAME': 'cltbld', 02:36:09 INFO - 'MAIL': '/var/mail/cltbld', 02:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:09 INFO - 'MOZ_NO_REMOTE': '1', 02:36:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:09 INFO - 'NO_EM_RESTART': '1', 02:36:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:09 INFO - 'PWD': '/builds/slave/test', 02:36:09 INFO - 'SHELL': '/bin/bash', 02:36:09 INFO - 'SHLVL': '1', 02:36:09 INFO - 'TERM': 'linux', 02:36:09 INFO - 'TMOUT': '86400', 02:36:09 INFO - 'USER': 'cltbld', 02:36:09 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', 02:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:09 INFO - '_': '/tools/buildbot/bin/python'} 02:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:09 INFO - Downloading/unpacking jsonschema==2.5.1 02:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:36:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:11 INFO - Downloading functools32-3.2.3-2.tar.gz 02:36:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:36:11 INFO - warning: no files found matching '*.txt' 02:36:11 INFO - no previously-included directories found matching 'build' 02:36:11 INFO - no previously-included directories found matching 'dist' 02:36:11 INFO - no previously-included directories found matching '.git*' 02:36:11 INFO - Installing collected packages: jsonschema, functools32 02:36:12 INFO - Running setup.py install for functools32 02:36:12 INFO - warning: no files found matching '*.txt' 02:36:12 INFO - no previously-included directories found matching 'build' 02:36:12 INFO - no previously-included directories found matching 'dist' 02:36:12 INFO - no previously-included directories found matching '.git*' 02:36:12 INFO - Successfully installed jsonschema functools32 02:36:12 INFO - Cleaning up... 02:36:12 INFO - Return code: 0 02:36:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:12 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f0451da8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaf20>, '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 0x2b57c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', '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 02:36:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:36:12 INFO - Using env: {'DISPLAY': ':0', 02:36:12 INFO - 'HOME': '/home/cltbld', 02:36:12 INFO - 'LANG': 'en_US.UTF-8', 02:36:12 INFO - 'LANGUAGE': 'en_US:en', 02:36:12 INFO - 'LOGNAME': 'cltbld', 02:36:12 INFO - 'MAIL': '/var/mail/cltbld', 02:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:12 INFO - 'MOZ_NO_REMOTE': '1', 02:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:12 INFO - 'NO_EM_RESTART': '1', 02:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:12 INFO - 'PWD': '/builds/slave/test', 02:36:12 INFO - 'SHELL': '/bin/bash', 02:36:12 INFO - 'SHLVL': '1', 02:36:12 INFO - 'TERM': 'linux', 02:36:12 INFO - 'TMOUT': '86400', 02:36:12 INFO - 'USER': 'cltbld', 02:36:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', 02:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:12 INFO - '_': '/tools/buildbot/bin/python'} 02:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:36:12 INFO - Cleaning up... 02:36:12 INFO - Return code: 0 02:36:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:12 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f0451da8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaf20>, '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 0x2b57c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', '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 02:36:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:36:12 INFO - Using env: {'DISPLAY': ':0', 02:36:12 INFO - 'HOME': '/home/cltbld', 02:36:12 INFO - 'LANG': 'en_US.UTF-8', 02:36:12 INFO - 'LANGUAGE': 'en_US:en', 02:36:12 INFO - 'LOGNAME': 'cltbld', 02:36:12 INFO - 'MAIL': '/var/mail/cltbld', 02:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:12 INFO - 'MOZ_NO_REMOTE': '1', 02:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:12 INFO - 'NO_EM_RESTART': '1', 02:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:12 INFO - 'PWD': '/builds/slave/test', 02:36:12 INFO - 'SHELL': '/bin/bash', 02:36:12 INFO - 'SHLVL': '1', 02:36:12 INFO - 'TERM': 'linux', 02:36:12 INFO - 'TMOUT': '86400', 02:36:12 INFO - 'USER': 'cltbld', 02:36:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', 02:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:12 INFO - '_': '/tools/buildbot/bin/python'} 02:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:12 INFO - Downloading/unpacking blobuploader==1.2.4 02:36:12 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 02:36:12 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 02:36:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:12 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 02:36:12 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 02:36:14 INFO - Downloading blobuploader-1.2.4.tar.gz 02:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:36:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:36:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:36: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 02:36: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 02:36:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36: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 02:36: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 02:36:15 INFO - Downloading docopt-0.6.1.tar.gz 02:36:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:36:15 INFO - Installing collected packages: blobuploader, requests, docopt 02:36:15 INFO - Running setup.py install for blobuploader 02:36:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:36:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:36:15 INFO - Running setup.py install for requests 02:36:15 INFO - Running setup.py install for docopt 02:36:15 INFO - Successfully installed blobuploader requests docopt 02:36:15 INFO - Cleaning up... 02:36:15 INFO - Return code: 0 02:36:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:15 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f0451da8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaf20>, '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 0x2b57c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', '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 02:36:15 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:36:15 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:36:15 INFO - Using env: {'DISPLAY': ':0', 02:36:15 INFO - 'HOME': '/home/cltbld', 02:36:15 INFO - 'LANG': 'en_US.UTF-8', 02:36:15 INFO - 'LANGUAGE': 'en_US:en', 02:36:15 INFO - 'LOGNAME': 'cltbld', 02:36:15 INFO - 'MAIL': '/var/mail/cltbld', 02:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:15 INFO - 'MOZ_NO_REMOTE': '1', 02:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:15 INFO - 'NO_EM_RESTART': '1', 02:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:15 INFO - 'PWD': '/builds/slave/test', 02:36:15 INFO - 'SHELL': '/bin/bash', 02:36:15 INFO - 'SHLVL': '1', 02:36:15 INFO - 'TERM': 'linux', 02:36:15 INFO - 'TMOUT': '86400', 02:36:15 INFO - 'USER': 'cltbld', 02:36:15 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', 02:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:15 INFO - '_': '/tools/buildbot/bin/python'} 02:36:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:16 INFO - Running setup.py (path:/tmp/pip-mX0OW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:16 INFO - Running setup.py (path:/tmp/pip-apfVPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:16 INFO - Running setup.py (path:/tmp/pip-6C0UJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:16 INFO - Running setup.py (path:/tmp/pip-G3oA5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:16 INFO - Running setup.py (path:/tmp/pip-KEyq8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:16 INFO - Running setup.py (path:/tmp/pip-E1b472-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:16 INFO - Running setup.py (path:/tmp/pip-tceSlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:16 INFO - Running setup.py (path:/tmp/pip-uL0iiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:16 INFO - Running setup.py (path:/tmp/pip-t3YMlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:16 INFO - Running setup.py (path:/tmp/pip-AfBfSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:16 INFO - Running setup.py (path:/tmp/pip-0envD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:16 INFO - Running setup.py (path:/tmp/pip-3TBYrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:17 INFO - Running setup.py (path:/tmp/pip-_lBaI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:17 INFO - Running setup.py (path:/tmp/pip-dm4RdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:17 INFO - Running setup.py (path:/tmp/pip-9E2RWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:17 INFO - Running setup.py (path:/tmp/pip-brh1s8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:17 INFO - Running setup.py (path:/tmp/pip-gYuFrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:36:17 INFO - Running setup.py install for manifestparser 02:36:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:36:17 INFO - Running setup.py install for mozcrash 02:36:17 INFO - Running setup.py install for mozdebug 02:36:17 INFO - Running setup.py install for mozdevice 02:36:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:36:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:36:17 INFO - Running setup.py install for mozfile 02:36:17 INFO - Running setup.py install for mozhttpd 02:36:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Running setup.py install for mozinfo 02:36:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Running setup.py install for mozInstall 02:36:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Running setup.py install for mozleak 02:36:18 INFO - Running setup.py install for mozlog 02:36:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Running setup.py install for moznetwork 02:36:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Running setup.py install for mozprocess 02:36:18 INFO - Running setup.py install for mozprofile 02:36:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Running setup.py install for mozrunner 02:36:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:36:18 INFO - Running setup.py install for mozscreenshot 02:36:19 INFO - Running setup.py install for moztest 02:36:19 INFO - Running setup.py install for mozversion 02:36:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:36:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:36:19 INFO - Cleaning up... 02:36:19 INFO - Return code: 0 02:36:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:19 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f0451da8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaf20>, '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 0x2b57c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', '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 02:36:19 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:36:19 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:36:19 INFO - Using env: {'DISPLAY': ':0', 02:36:19 INFO - 'HOME': '/home/cltbld', 02:36:19 INFO - 'LANG': 'en_US.UTF-8', 02:36:19 INFO - 'LANGUAGE': 'en_US:en', 02:36:19 INFO - 'LOGNAME': 'cltbld', 02:36:19 INFO - 'MAIL': '/var/mail/cltbld', 02:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:19 INFO - 'MOZ_NO_REMOTE': '1', 02:36:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:19 INFO - 'NO_EM_RESTART': '1', 02:36:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:19 INFO - 'PWD': '/builds/slave/test', 02:36:19 INFO - 'SHELL': '/bin/bash', 02:36:19 INFO - 'SHLVL': '1', 02:36:19 INFO - 'TERM': 'linux', 02:36:19 INFO - 'TMOUT': '86400', 02:36:19 INFO - 'USER': 'cltbld', 02:36:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', 02:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:19 INFO - '_': '/tools/buildbot/bin/python'} 02:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:19 INFO - Running setup.py (path:/tmp/pip-2RirIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:19 INFO - Running setup.py (path:/tmp/pip-Q1g_zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:19 INFO - Running setup.py (path:/tmp/pip-nA7Omx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:19 INFO - Running setup.py (path:/tmp/pip-kg88Bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:19 INFO - Running setup.py (path:/tmp/pip-gR1woL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:19 INFO - Running setup.py (path:/tmp/pip-vqJe7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:19 INFO - Running setup.py (path:/tmp/pip-8Rb74s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:19 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)) 02:36:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:19 INFO - Running setup.py (path:/tmp/pip-BZ4Ifv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:20 INFO - Running setup.py (path:/tmp/pip-41kTL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:20 INFO - Running setup.py (path:/tmp/pip-C449Wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:20 INFO - Running setup.py (path:/tmp/pip-cXT_CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:20 INFO - Running setup.py (path:/tmp/pip-dW8pVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:20 INFO - Running setup.py (path:/tmp/pip-maY1kN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:20 INFO - Running setup.py (path:/tmp/pip-gjbBm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:20 INFO - Running setup.py (path:/tmp/pip-3QeCog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:20 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:20 INFO - Running setup.py (path:/tmp/pip-OcZcyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 02:36:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:20 INFO - Running setup.py (path:/tmp/pip-SZyPzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:20 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)) 02:36:20 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)) 02:36:20 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)) 02:36:20 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)) 02:36:20 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:36:20 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:36:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:36: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 02:36: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 02:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36: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 02:36: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 02:36:22 INFO - Downloading blessings-1.6.tar.gz 02:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:36:22 INFO - Installing collected packages: blessings 02:36:22 INFO - Running setup.py install for blessings 02:36:22 INFO - Successfully installed blessings 02:36:22 INFO - Cleaning up... 02:36:22 INFO - Return code: 0 02:36:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:23 INFO - Reading from file tmpfile_stdout 02:36:23 INFO - Current package versions: 02:36:23 INFO - argparse == 1.2.1 02:36:23 INFO - blessings == 1.6 02:36:23 INFO - blobuploader == 1.2.4 02:36:23 INFO - docopt == 0.6.1 02:36:23 INFO - functools32 == 3.2.3-2 02:36:23 INFO - jsonschema == 2.5.1 02:36:23 INFO - manifestparser == 1.1 02:36:23 INFO - mozInstall == 1.12 02:36:23 INFO - mozcrash == 1.0 02:36:23 INFO - mozdebug == 0.1 02:36:23 INFO - mozdevice == 0.49 02:36:23 INFO - mozfile == 1.2 02:36:23 INFO - mozhttpd == 0.7 02:36:23 INFO - mozinfo == 0.9 02:36:23 INFO - mozleak == 0.1 02:36:23 INFO - mozlog == 3.4 02:36:23 INFO - moznetwork == 0.27 02:36:23 INFO - mozprocess == 0.23 02:36:23 INFO - mozprofile == 0.28 02:36:23 INFO - mozrunner == 6.13 02:36:23 INFO - mozscreenshot == 0.1 02:36:23 INFO - mozsystemmonitor == 0.3 02:36:23 INFO - moztest == 0.7 02:36:23 INFO - mozversion == 1.4 02:36:23 INFO - psutil == 3.1.1 02:36:23 INFO - requests == 1.2.3 02:36:23 INFO - wsgiref == 0.1.2 02:36:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f0451da8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaf20>, '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 0x2b57c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', '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 02:36:23 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 02:36:23 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:36:23 INFO - Using env: {'DISPLAY': ':0', 02:36:23 INFO - 'HOME': '/home/cltbld', 02:36:23 INFO - 'LANG': 'en_US.UTF-8', 02:36:23 INFO - 'LANGUAGE': 'en_US:en', 02:36:23 INFO - 'LOGNAME': 'cltbld', 02:36:23 INFO - 'MAIL': '/var/mail/cltbld', 02:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:23 INFO - 'MOZ_NO_REMOTE': '1', 02:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:23 INFO - 'NO_EM_RESTART': '1', 02:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:23 INFO - 'PWD': '/builds/slave/test', 02:36:23 INFO - 'SHELL': '/bin/bash', 02:36:23 INFO - 'SHLVL': '1', 02:36:23 INFO - 'TERM': 'linux', 02:36:23 INFO - 'TMOUT': '86400', 02:36:23 INFO - 'USER': 'cltbld', 02:36:23 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', 02:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:23 INFO - '_': '/tools/buildbot/bin/python'} 02:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 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)) 02:36:23 INFO - Cleaning up... 02:36:23 INFO - Return code: 0 02:36:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:23 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f0451da8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29bca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b5a120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2beaf20>, '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 0x2b57c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57f90>, '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': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', '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 02:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:36:23 INFO - Using env: {'DISPLAY': ':0', 02:36:23 INFO - 'HOME': '/home/cltbld', 02:36:23 INFO - 'LANG': 'en_US.UTF-8', 02:36:23 INFO - 'LANGUAGE': 'en_US:en', 02:36:23 INFO - 'LOGNAME': 'cltbld', 02:36:23 INFO - 'MAIL': '/var/mail/cltbld', 02:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:23 INFO - 'MOZ_NO_REMOTE': '1', 02:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:23 INFO - 'NO_EM_RESTART': '1', 02:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:23 INFO - 'PWD': '/builds/slave/test', 02:36:23 INFO - 'SHELL': '/bin/bash', 02:36:23 INFO - 'SHLVL': '1', 02:36:23 INFO - 'TERM': 'linux', 02:36:23 INFO - 'TMOUT': '86400', 02:36:23 INFO - 'USER': 'cltbld', 02:36:23 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', 02:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:23 INFO - '_': '/tools/buildbot/bin/python'} 02:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:36:23 INFO - Cleaning up... 02:36:23 INFO - Return code: 0 02:36:23 INFO - Running post-action listener: _resource_record_post_action 02:36:23 INFO - Running post-action listener: _start_resource_monitoring 02:36:23 INFO - Starting resource monitoring. 02:36:23 INFO - [mozharness: 2016-12-10 10:36:23.634530Z] Finished create-virtualenv step (success) 02:36:23 INFO - [mozharness: 2016-12-10 10:36:23.635035Z] Running install step. 02:36:23 INFO - Running pre-action listener: _resource_record_pre_action 02:36:23 INFO - Running main action method: install 02:36:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:23 INFO - Reading from file tmpfile_stdout 02:36:23 INFO - Detecting whether we're running mozinstall >=1.0... 02:36:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:36:23 INFO - Reading from file tmpfile_stdout 02:36:23 INFO - Output received: 02:36:23 INFO - Usage: mozinstall [options] installer 02:36:23 INFO - Options: 02:36:23 INFO - -h, --help show this help message and exit 02:36:23 INFO - -d DEST, --destination=DEST 02:36:23 INFO - Directory to install application into. [default: 02:36:23 INFO - "/builds/slave/test"] 02:36:23 INFO - --app=APP Application being installed. [default: firefox] 02:36:23 INFO - mkdir: /builds/slave/test/build/application 02:36:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:36:39 INFO - Reading from file tmpfile_stdout 02:36:39 INFO - Output received: 02:36:39 INFO - /builds/slave/test/build/application/firefox/firefox 02:36:39 INFO - Running post-action listener: _resource_record_post_action 02:36:39 INFO - [mozharness: 2016-12-10 10:36:39.978719Z] Finished install step (success) 02:36:39 INFO - [mozharness: 2016-12-10 10:36:39.978957Z] Running run-tests step. 02:36:39 INFO - Running pre-action listener: _resource_record_pre_action 02:36:39 INFO - Running main action method: run_tests 02:36:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:36:39 INFO - Python 2.7.3 02:36:39 INFO - Return code: 0 02:36:39 INFO - grabbing minidump binary from tooltool 02:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 02:36:39 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 0x2beaf20>, '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 0x2b57c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b57f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:36:39 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 02:36:39 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 02:36:39 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 02:36:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:36:40 INFO - Return code: 0 02:36:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:36:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:36:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:36:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:36:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:36:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 02:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 02:36:40 INFO - Using env: {'DISPLAY': ':0', 02:36:40 INFO - 'HOME': '/home/cltbld', 02:36:40 INFO - 'LANG': 'en_US.UTF-8', 02:36:40 INFO - 'LANGUAGE': 'en_US:en', 02:36:40 INFO - 'LOGNAME': 'cltbld', 02:36:40 INFO - 'MAIL': '/var/mail/cltbld', 02:36:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:36:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:40 INFO - 'MOZ_NO_REMOTE': '1', 02:36:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:40 INFO - 'NO_EM_RESTART': '1', 02:36:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:40 INFO - 'PWD': '/builds/slave/test', 02:36:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:36:40 INFO - 'SHELL': '/bin/bash', 02:36:40 INFO - 'SHLVL': '1', 02:36:40 INFO - 'TERM': 'linux', 02:36:40 INFO - 'TMOUT': '86400', 02:36:40 INFO - 'USER': 'cltbld', 02:36:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615', 02:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:40 INFO - '_': '/tools/buildbot/bin/python'} 02:36:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 02:36:40 INFO - mozversion application_buildid: 20161210014650 02:36:40 INFO - mozversion application_changeset: 9563f383566a5deb84d7b16e0f06426006b530f0 02:36:40 INFO - mozversion application_display_name: Nightly 02:36:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:36:40 INFO - mozversion application_name: Firefox 02:36:40 INFO - mozversion application_remotingname: firefox 02:36:40 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 02:36:40 INFO - mozversion application_vendor: Mozilla 02:36:40 INFO - mozversion application_version: 53.0a1 02:36:40 INFO - mozversion platform_buildid: 20161210014650 02:36:40 INFO - mozversion platform_changeset: 9563f383566a5deb84d7b16e0f06426006b530f0 02:36:40 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 02:36:40 INFO - mozversion platform_version: 53.0a1 02:36:40 INFO - using testdate: 1481366200 02:36:40 INFO - actual date: 1481366200 02:36:40 INFO - starting webserver on 'localhost:32863' 02:36:40 INFO - SUITE-START | Running 2 tests 02:36:40 INFO - TEST-START | dromaeo_css 02:36:40 INFO - operating with platform_type : linux_ 02:36:40 INFO - Initialising browser for dromaeo_css test... 02:36:40 INFO - TEST-INFO | started process 5476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpexDYHT/profile http://localhost:32863/getInfo.html) 02:36:44 INFO - PROCESS | 5476 | __metrics Screen width/height:1600/1200 02:36:44 INFO - PROCESS | 5476 | colorDepth:24 02:36:44 INFO - PROCESS | 5476 | Browser inner width/height: 1024/697 02:36:44 INFO - PROCESS | 5476 | __metrics 02:36:45 INFO - PROCESS | 5476 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:36:45 INFO - PROCESS | 5476 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:36:45 INFO - PROCESS | 5476 | console.error: PushService: 02:36:45 INFO - PROCESS | 5476 | stateChangeProcessEnqueue: Error transitioning state 02:36:45 INFO - PROCESS | 5476 | UnknownError 02:36:46 INFO - TEST-INFO | 5476: exit 0 02:36:46 INFO - Browser initialized. 02:36:46 INFO - Running cycle 1/1 for dromaeo_css test... 02:36:46 INFO - TEST-INFO | started process 5557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpexDYHT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:36:58 INFO - PROCESS | 5557 | RSS: Main: 174055424 02:36:58 INFO - PROCESS | 5557 | 02:37:49 INFO - PROCESS | 5557 | 1481366269881 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:40:04 INFO - PROCESS | 5557 | Cycle 1(1): loaded http://localhost:32863/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32863/tests/dromaeo/cssquery-ext.html) 02:40:05 INFO - PROCESS | 5557 | RSS: Main: 309817344 02:40:05 INFO - PROCESS | 5557 | 02:43:08 INFO - PROCESS | 5557 | Cycle 1(1): loaded http://localhost:32863/tests/dromaeo/cssquery-ext.html (next: http://localhost:32863/tests/dromaeo/cssquery-jquery.html) 02:43:09 INFO - PROCESS | 5557 | RSS: Main: 276746240 02:43:09 INFO - PROCESS | 5557 | 02:46:11 INFO - PROCESS | 5557 | Cycle 1(1): loaded http://localhost:32863/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32863/tests/dromaeo/cssquery-mootools.html) 02:46:12 INFO - PROCESS | 5557 | RSS: Main: 222396416 02:46:12 INFO - PROCESS | 5557 | 02:49:14 INFO - PROCESS | 5557 | Cycle 1(1): loaded http://localhost:32863/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32863/tests/dromaeo/cssquery-prototype.html) 02:49:15 INFO - PROCESS | 5557 | RSS: Main: 220045312 02:49:15 INFO - PROCESS | 5557 | 02:52:18 INFO - PROCESS | 5557 | Cycle 1(1): loaded http://localhost:32863/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32863/tests/dromaeo/cssquery-yui.html) 02:52:19 INFO - PROCESS | 5557 | RSS: Main: 219299840 02:52:19 INFO - PROCESS | 5557 | 02:55:22 INFO - PROCESS | 5557 | Cycle 1(1): loaded http://localhost:32863/tests/dromaeo/cssquery-yui.html (next: http://localhost:32863/tests/dromaeo/cssquery-dojo.html) 02:55:22 INFO - PROCESS | 5557 | RSS: Main: 312242176 02:55:22 INFO - PROCESS | 5557 | 02:55:22 INFO - PROCESS | 5557 | __start_tp_report 02:55:22 INFO - PROCESS | 5557 | _x_x_mozilla_page_load 02:55:22 INFO - PROCESS | 5557 | _x_x_mozilla_page_load_details 02:55:22 INFO - PROCESS | 5557 | |i|pagename|runs| 02:55:22 INFO - PROCESS | 5557 | |0;dojo.html;2569.71733109358;2587.6118582212666;2597.6363309136714;2625.1861922803932;2637.3142982824447;4531.909361812762;4570.542945705428;4612.723236605806;4687.343771871936;4708.411448568929;4613.354130421735;4678.5789278964885;4711.623070154388;4741.668083234175;4808.639352048593;4248.97875510622;4264.573542645726;4294.334378171388;4322.675799315049;4385.780710964455;3976.960230397688;4301.462317210348;4394.450693663292;4428.955710442902;4481.865544033684;4208.789560521992;4244.830206791725;4383.211022016036;4419.558044195587;4436.911261774762;4279;4279.935800962957;4302.806373713191;4305.892352691177;4310.3103503439615;4275.978620106911;4315.870523884289;4316.093620339732;4376.518582955872;4384;4684.742339171345;4718.858434246944;4727.976360118178;4752.025834703877;4772.451168115642;4959.380077490314;4990.975045124787;5032.6477146599755;5043.142665746832;5047.0915235257635;4962.255661650745;5012.147934851084;5019.824306149304;5035.043341765053;5094.261332106824;4696.600788932945;4700.341952126705;4701.6003639690325;4705.388299521041;4749.857504274877;5117.309163262987;5119.829504996791;5121.385433747974;5128.538431541105;5166.9224961625605;4817.518248175154;4824.445188803263;4872.342233798463;4875.268709693574;4875.609951203895;4956.900861982812;4963.10664080469;4963.677360971526;4966.081274964144;4967.031428871408;4890.144224760653;4919.680220785637;4929.654924155347;4930.901381972412;4931.556159945622;4915.975420122948;4925.581325587365;4928.852134435972;4931.457539670633;4940.604751619933;4301.913961720748;4304.3543468479975;4305.203537345601;4306.138772245501;4311.504177019683;3722.813859307024;3760.8871733848027;3765.322241996467;3824.330742120118;3859.4403811447746;4332.328489084197;4334.783260836945;4338.783060846945;4364.039911219526;4378.540253273361;5050.873728156826;5086.618503612244;5093.2360145977655;5094;5140.280360749498;4179.519355274121;4216.9789151054665;4219.177260434247;4265.338872474771;4351.782410879443;4483.708558943658;4557.316402539645;4560.908781824345;4575.428071491064;4610.124076425468;4690.906181876343;4707.693999889996;4723.409573803275;4733.763311834326;4779.737114458599;5083.085044691843;5084.3898732152375;5094.388673359221;5096.694198348111;5143.61422893277;4551.06703125865;4593.150267200579;4603.884902877455;4607.216773148506;4618.03021365517;4897.583705385082;4916.287138364845;4918.286848407032;4964.379452568429;4967.230079337708;4972.2790195422185;4985.8005679772405;4994.900101998012;4996.925046124384;5046.116929537389;4735.550122738335;4770.379850619397;4773.451053128796;4810.278458231293;4858.878528036827;4810.182269014206;4812.398450193726;4818.518148185153;4864.659473836798;4875.268709693574;4790.808367665394;4822.638302127425;4824.807007719652;4838.612910967185;4879.414470263591;4772.093302272557;4937.728424936663;4937.8271760488215;4941.703497790144;4991.126552853309;4682.321063445713;4793.616510679207;4797.784099715591;4817.759112044454;4841 02:55:22 INFO - PROCESS | 5557 | |1;ext.html;525.5401523666792;530.7134147560315;551.2310327093702;564.4947771744289;581.128307538692;26971.190864274053;36623.81688091559;38396.99999999996;38770.61229387705;42022.159556808845;38610;38916.41625375614;38936.61063389365;39008.21983560327;39008.21983560334;7218.458615603825;7377.77866664001;7386.852262954764;7396.741114061009;7396.815079622998;7344.779656610311;7564.130125035636;9315.276673815366;9651.71044868655;9661.275404344668;9482.241420686363;9541.33210675253;9547.522623868814;9547.570359333846;9560.378575392611;9582.760430989247;9661.46861922594;9667.226621870233;9674.56464459101;9680.612775488971;9546.236301095896;9610.519474026341;9619.230461563058;9620.615175392975;9624.326297159201;36939.26121477556;37216.627833721584;37239.627603723886;37248;37327.4400883987;2972.524396096614;3082.1061892051503;3151.5745374374396;3201.4557525220766;3377.8986630401128;26954.5956810648;27451.862740686367;27571.86214068937;27961.300967475774;28193;3433.6738009889023;3453.7755045921936;3474.2356681530277;3505.2814173094453;3534.7525673202886;231953;233496;234316;234440.82779586164;234654;51469.742651286506;51791;51882;51912.48087519152;51920.74039629778;53512.19731704028;53895.19157212645;53951.730241348545;54049.72975135099;54066.72966635141;14522.419103235752;14927.552173434815;14963.401463941538;14976.475823346349;14977.326020329112;9923.751906202258;10128.430093335544;11539.826902596467;11638.6508404748;11647.359395233174;15255.160966146968;15620.609484762972;15723.606909827346;16151.434699785452;16193.028418294705;5728.140778883201;5804.709764511842;5814.319158600967;5875.20684707559;5899.76400943966;748.8352562436255;811.703728139225;887.9112088791069;947.0766003146877;974.9561269742878;26163.215103546925;27120.457590848073;27170;27577.17268481949;27600.309992250353;903.9954800225956;918.9035151309016;940.6519587752439;965.5703212070562;999.14073896449;14198;14362.353694083791;14476;14632.707345853023;14695.191764453059;333684;335641;336582;336825;338193;46940.5305946943;47007;47030.76484617624;47074.293885591745;47364.7631761839;1029.2332212501733;1111.7053980694961;1132.8753837077916;1157.3576664950697;1207.4144040140525;24229.394265142808;25749.3562660935;26066.60900086538;26164;27834.87632720798;40013.599864000986;40684.79657601812;40777.796111019255;40875.7956210217;40881.795591023045;319080;321506;321614;321657;322756;21970.45073873166;22431.887840560692;22816.087356505555;22843.428914277276;24049.158279460135;35017.124571885906;35260.11849703778;35421.82289088538;35513.28973420569;36613.450798238584;29817;29962.700372996864;29999;30268.84865575658;31218;29428;29873;30342.54486182665;30453.23866903345;30689.38621227518;28583.28541786472;30787.384252315278;31082.22294442657;31127;31328;25947.740522595286;27771.44457110887;27948;28428.289292767848;28478.715212847605;21837.454063648536;22196.556068878854;22585.887070564542;22755.772442275364;22769.316920492412 02:55:22 INFO - PROCESS | 5557 | |2;jquery.html;342.06391822285866;351.4464718069042;358.53211558915615;365.8975486863679;380.48121436093066;12206.389680515971;13183.340832958362;15134.772978405334;15680;15809.920950395232;15892.364305427798;16016.19919004051;16201;16292.592685182877;16423.83576164238;4856.902861942768;4857.101436234308;5085.949140508603;5095.694258344512;5099.923501147486;4964.453910069889;5012.448630650625;5051.621128415383;5055.6713813602;5058.772355244005;5023.497650234984;5024.5226703463295;5030.522100400474;5030.7987680492915;5032.84901452957;4759.666823322369;4980.601551875841;4986.4265609455015;4995.025969935864;4996.300517927457;4464;4464.620507256887;4466.235836844428;4467.463904331501;4467.843625473125;19197.136128874095;19284;19383.612327753508;19557.804421955883;19793.9010304949;1847.6951303034982;1962.705594160873;1963.0871644685146;1968.0651690447066;1977.2881762565464;11839.94080029603;12564;12628.305443200621;12866.485340586365;13196.60410187696;1697.8981261124372;1716.4078392954411;1720.131333676498;1764.1267572551542;1817.8363947244811;65797;66197.66901165512;66256.08006438699;66488.66755666239;66634.3336566633;8608.139186081467;8664.653413863502;8865.512396818236;8886.155815197546;9217.493037882981;12085.637430877088;12095.213811102427;12102;12110.212836165798;12146.817797732865;6894.896576551356;7035.1909530404655;7218.6390680465765;7372;7375.336219740249;6972.581645101209;7060.940858871108;7061.540999834994;7131.500794944304;7192.388646965067;5737.741801618937;5863.70681465925;5874.236349274567;5918.911216331759;6063.787767428119;1693.3734518228089;1743.8168992255885;1745.1972092837436;1772.7735521351274;1804.115983168238;755.3088923634813;794.5709316968772;833.9041010283895;879.6041781198486;914.0265617117748;15183.468578599917;15896.841031589767;16200.108994005208;16264.268107935171;16850.747238791428;826.3843436639742;826.7850358906727;849.4945507423197;856.9742907712779;860.655737704923;9027.36808423404;9312.115349041831;9504.572294246775;9510.524473776284;9544.188743956702;257918;259576;260351;358262;358430;72954.2704572958;72980;73764.63117684377;74926.62536687282;76307.23692763002;876.6931573949067;920.3787443475761;941.4163218804385;948.6063283737171;949.292776881228;14648.12111273327;14971.101733896001;15304;15322.233888305764;15667.138307393203;30393.392132157674;34744.82627586846;35718.64281357153;35855;36381.454278185316;48893.51106489032;49607;49662.75168624134;49708;50311.49688503068;6771.356721111487;6844.897326540006;6854.451643868579;6988.161420629353;7002.544834585736;8271.296939760188;9907.603695852085;11059.72350691239;11066.944665276622;11620.6513804586;9320.254379649476;9459.668911588062;9627.759306017406;9669.129778319984;9778.462184579916;9657.46883921363;9878.802423951625;9889.703308900744;9939.254555908481;10078.395296282246;9560.808783824146;9683.128518433376;9771.218302535923;10048.145907597936;10171.7457063574;7055.082839230867;7066.540674856118;7122.821929451805;7229.963850180716;7301.196868344372;8160.347172226327;9651.083147101013;9714.174295184988;9837.360571562825;10010.14913732341 02:55:22 INFO - PROCESS | 5557 | |3;mootools.html;1209.3529961470615;1310.685435495481;1315.2568798628774;1386.431563059146;1618.1100394782875;6190.411910868472;7113.715451381945;7277.927220727798;7298.124225092996;7519.6616152273145;7331.816704582375;7374.557526548411;7399.149097853749;7405.074365704287;7416.22129676383;1792.2024699008946;2077.9896100519513;2104.9473763155966;2110.5145816462145;2117.650587653043;1871.681814091601;1987.85091118166;2049.9692504612444;2054.291269512016;2082.0422605601443;2068.276103363818;2075.7716651168357;2087.3633541769755;2089.3731880435885;2090;2033.6339458897392;2076.439361372421;2077.885716285619;2077.9064942077644;2079.054030416157;2064.494198921259;2080.9687854682193;2089.7701252862325;2090.613236551243;2097.129691178159;7317;7361.779146625609;7387.261273872624;7445.9627701861145;7477.813054673622;4308.116836048603;4453.242948698697;4468.218061839165;4476.6418686505;4482.21561226784;2598.610208468726;2693.5690289553772;2753.105240796749;2759.558470644707;2765.1566272286946;846.8179341441559;886.5567216391804;886.7384121684119;901.6753968571309;902.0798785239019;9593;9610.711678649652;9711.223102151811;9729.173020293283;9730.513474326255;3717.4795528626014;3814.771113733185;3910.589388114264;3911.8239679214503;4120;8453;8481.363897707697;8483.533405662625;8487.278581320534;8495.405321627426;4349.173657005159;4423.955760442419;4424.756638384855;4448.043670610834;4465.955340446619;3560.946585801215;3673.173535954389;4033.1127152026506;4051.0277533391773;4061.5126184858004;3299.851506682205;3425.5718035245595;3500.789952602852;3520.612732599412;3534.3108093921437;1113.2986218682179;1123.4888125902694;1131.2533727739653;1140.509580880213;1147.3460127727114;830.1781236575747;839.9454035487673;856.3705676327894;860.4708104515678;892.7723430525175;4959.231319145466;5055.6713813602;5061.164907790247;5103.974480127576;5221.921671174935;400.1157442053037;403.73958796576045;410.20420384454064;410.86030749545296;414.86309517859036;3493.9126521837156;3530.505729197914;3600.405933021022;3617.963820361763;3652.0687224757517;8530.573471326408;8787.648494060166;8874.689385871592;8887.333449991147;8907.331950103768;8848.20366167048;8858.379913406128;8863.468191908507;8869.64521419136;8870.467771933576;6653.600783952978;6835.179778426521;6859.382655561023;6905.447564194852;6946.2011868635755;4821.349117869183;4836.613070954245;5165.870853228549;5176.870578235575;5312.229726689531;7950.801229969297;7999.880001800094;8077.434579579373;8173;8216.301614362847;8117.472364296302;8183.631736571988;8291.83416331682;8350.665973361241;8398.370122240734;5643.322801263875;5799.913001305068;6353.7140828661895;6456.9354306456335;6533.41199292066;6742.86514269702;6991.021257023919;6994.510384273052;7087.255838136922;7107.182673992557;6332.398422149889;6356.046593011085;6407.1350367701625;6608.372204640552;6620.437262832521;6375.585586936834;6431.839204019937;6438.678066096582;6441.5490915635455;6473;6002.669853158118;6107.144999700135;6132.233470816148;6142.938570614416;6144.2319710036245;4416;4515.458145022619;4571.931421028754;4577.198990176772;4606.055758569418;4416.492103408149;4452.732836029719;4575.6339492839825;4580.656450766272;4758.214894542501 02:55:22 INFO - PROCESS | 5557 | |4;prototype.html;314.30224900720395;330.95697559317284;332.5693227270687;340.0614304519526;340.06821309611655;4840.298156767271;4879.560839524442;4884.658073934826;4893.29047288143;4897.975510122454;4737.549932756391;4764.856434455732;4816.951830481694;4823.348847905531;4862.7325497097645;3627.4740162676394;3757.7557458765227;3794.9810250948844;3803.3724435468116;3839.1361943562615;3827.349350610389;3841.654251117399;3850.4416859555486;3858.401947698111;3862.1889403225355;3821.675157611606;3829.3681542545446;3829.4490731253886;3846.653801157895;3854.691624670034;3674.724395670322;3768.7550309230087;3778.678812300958;3829.253295607358;3852.57621661617;3452.879149229765;3459.7232221422228;3462.1690794209208;3466;3516.6307537708685;4594.724316541018;4628.722276663411;4644.674872758875;4669.299605059235;4675.251959686468;4314.856563010805;4392.407025051609;4400.163968845941;4404.427424434803;4431.689781715281;4996.325496058058;5007.4241462231585;5008.824691135793;5009.048280826668;5033.219850923113;3741.7567858089137;3746.3818469952425;3748.463130116639;3762.2099359134613;3774.0942173878348;5143;5261.159353671841;5267.947320526784;5283.947160528384;5284.4187139414635;3824.2160357126722;3834.2331533693373;3848.9807550962064;3872.5740168581433;3889.3470275133523;3921.058945852975;3934.7639141651593;3935.6225321137945;3943.1127996200626;3947.072437977073;4366.694331396835;4393.494748103945;4427.8228870844805;4434.268345722984;4437.291642717512;4861.4895435978715;5037.722925239147;5038.798448062036;5040.243963405518;5077.720725360066;1323.2655875988726;1323.3118778235264;1330.8935285177163;1332.187365706918;1339.71196192819;917.6831247160346;946.7159852044359;963.1411376044301;965.7730433348157;967.327707243459;4305.201618947709;4311.762853043113;4416.9779151104685;4444.777761111932;4450.109978004347;5175.275461435402;5188.377394712583;5189.117849965515;5199.1161502544655;5221.817236396784;4428.512863585003;4445.2887537993765;4454.799534020977;4461.420015397977;4487.192305384997;2593.2738833126755;2638.9736102639113;2641.339665083729;2671.252049426164;2679.9682122383024;4720.480747117815;4742.881427964259;4756.575265808612;4757.310190022427;4762.809487620457;4949.727764972961;5164.7934082636275;5172.301739265151;5236.345456817898;5240.816571419982;4628.652851036119;4683.625309975126;4687.835925742583;4689.413823272091;4715.481297057389;5038.496150384932;5047.823326183566;5103.464136265638;5110.310108135354;5110.744462776772;4816.133096042746;4996.550310472075;5010.799568017239;5033.974830125826;5035.521625445577;4738.265568836836;4749.3113498541825;4773.331733557374;4789.353437285922;4827.565519103297;3845.9807700961314;3846.4614953907035;3849.287881741887;3851.017990412427;3886.378179491268;5073.242576227984;5114.488551144856;5115.232715092766;5152.510511501401;5163.173892177234;4813.748425409349;4955.851324460272;4960.727160006234;4977.626677999092;5008.373953255843;4955.331030311006;4961.5534601886;4976.253561965734;4994.401791426709;5001.799928002984;4708.858734237979;4841.273808928689;4869.756512174448;4874.53691899269;4945.802167913387;4842.491538388418;4848.866498740543;4927.728974906415;4955.677880937727;4973.801047958041;4835.830745923876;4955.925661115159;4975.129352363394;4981.551660350586;4999.325091112799 02:55:22 INFO - PROCESS | 5557 | |5;yui.html;619.8171539395878;628.8836565235432;675.362708622828;710.3677726823125;741.9220981796908;13350.732985340288;14090;14095.859041409596;14108.858911410884;14111.223882686436;13075.28085955272;13112.606621801362;13124;13148.539801106963;13258.867411325884;618.1006635345584;633.7021599848064;762.5500954436881;768.7040489411589;776.022212012865;764.8317370178552;783.1033466680648;785.2461636828623;785.4933567848734;785.7564155111905;822.5352675738219;823.238504383446;823.7405217356544;823.9093699693029;824.8102936324619;650.7592190889354;664.7473959895257;789;816.7835523586255;817.7710241132493;600.3726106219011;604.8366940925926;605.2283338743093;605.3613437823095;605.4702135631322;13453;13460.394282257323;13469.12450690702;13489.797653035212;13490.258035808027;12974.156679815782;13033.86966130336;13113.213207207502;13197.27414992175;13268.800967985488;11911.880881191164;12034.398280086049;12093;12284.385780711018;12310.630681079581;4011.538673052607;4031.153457773871;4065.837366505366;4117.1765646870745;4125.360569111793;65684.3431565683;66192.66903665499;67432.32567674358;68217;68783.65608171978;9945.254105942084;10031.398116113056;10122.746931326628;10196.592136314464;10238.488075596191;19672.901635492017;19698.507537311394;19702.40892773219;19718.507037324183;19812;6621.801345959629;6682.83292917681;6789.321067893171;6794.8641027180165;6919.792406227822;3573.2317551726505;3601.0637234319265;3601.2977469393218;3617.04148400674;3640.690541303966;2771.9584206236923;2805.985970070137;2807.2560771395597;2816.4367126574357;2833.744962953303;453.77991674038066;460.0201570654485;460.7005446459761;460.9446866375989;469.36869909971034;538.7662253439657;542.2056686953553;543.1445473379364;543.2584522127268;548.9670619762827;7054.75308364215;7400.666969986363;7611.3530349919765;7786.805329866798;7815;514.0797971630739;535.5394360849666;550.8540236837241;620.3920158244855;625.2340882419;3538.716902647782;3911.765294082364;4171.645410140111;4195.97902010488;4220.662347012231;49013.26480102801;50145.2362025607;51987.74006129945;60716;62140.689296554134;50600.349912521866;50753;51400.74299628478;52478.21282680763;53375.466245337826;45498.545014550094;47865.28202076902;48669;48964.26553601699;49325.26012109821;7911.643976020978;8401.579921004048;8475.449095808754;8517.531535765593;8631.91368086311;32821;32822.179445514055;32961.83519082389;34323;34615.480767788;40751.388729168495;41005.974850628976;45101.77449112733;46094.30858537058;46484.30273545967;10833;10895.618653347095;11082.279651822606;11283.153763467937;11436.599719010128;11833.46749396262;11908.225965312227;12437.93781031089;12438.751224975269;12642.30467324306;11246.212765106364;11609.593664221711;11689.240199387013;11762.94118529402;12509.186902851285;11989.160758746804;12252.75494490123;12303;12964.870351296744;13047.478100876238;11717.589884354007;11765.235259708092;11781;11785.175037747274;12451.501939922664;9221.446713197229;9229.538523073685;9838.803223935338;9855.852162217716;9892.258080643836;9228.676996305097;9527.952360238154;9536.23710103204;9539.904600953902;9542.284328675238 02:55:22 INFO - PROCESS | 5557 | __end_tp_report 02:55:22 INFO - PROCESS | 5557 | __start_cc_report 02:55:22 INFO - PROCESS | 5557 | _x_x_mozilla_cycle_collect,1349 02:55:22 INFO - PROCESS | 5557 | __end_cc_report 02:55:22 INFO - PROCESS | 5557 | __startTimestamp1481367322296__endTimestamp 02:55:22 INFO - PROCESS | 5557 | 02:55:22 INFO - PROCESS | 5557 | ------- Summary: start ------- 02:55:22 INFO - PROCESS | 5557 | Number of tests: 6 02:55:22 INFO - PROCESS | 5557 | 02:55:22 INFO - PROCESS | 5557 | [#0] dojo.html Cycles:165 Average:4625.90 Median:4749.86 stddev:479.09 (10.1%) stddev-sans-first:452.59 02:55:22 INFO - PROCESS | 5557 | Values: 2569.7 2587.6 2597.6 2625.2 2637.3 4531.9 4570.5 4612.7 4687.3 4708.4 4613.4 4678.6 4711.6 4741.7 4808.6 4249.0 4264.6 4294.3 4322.7 4385.8 3977.0 4301.5 4394.5 4429.0 4481.9 4208.8 4244.8 4383.2 4419.6 4436.9 4279.0 4279.9 4302.8 4305.9 4310.3 4276.0 4315.9 4316.1 4376.5 4384.0 4684.7 4718.9 4728.0 4752.0 4772.5 4959.4 4991.0 5032.6 5043.1 5047.1 4962.3 5012.1 5019.8 5035.0 5094.3 4696.6 4700.3 4701.6 4705.4 4749.9 5117.3 5119.8 5121.4 5128.5 5166.9 4817.5 4824.4 4872.3 4875.3 4875.6 4956.9 4963.1 4963.7 4966.1 4967.0 4890.1 4919.7 4929.7 4930.9 4931.6 4916.0 4925.6 4928.9 4931.5 4940.6 4301.9 4304.4 4305.2 4306.1 4311.5 3722.8 3760.9 3765.3 3824.3 3859.4 4332.3 4334.8 4338.8 4364.0 4378.5 5050.9 5086.6 5093.2 5094.0 5140.3 4179.5 4217.0 4219.2 4265.3 4351.8 4483.7 4557.3 4560.9 4575.4 4610.1 4690.9 4707.7 4723.4 4733.8 4779.7 5083.1 5084.4 5094.4 5096.7 5143.6 4551.1 4593.2 4603.9 4607.2 4618.0 4897.6 4916.3 4918.3 4964.4 4967.2 4972.3 4985.8 4994.9 4996.9 5046.1 4735.6 4770.4 4773.5 4810.3 4858.9 4810.2 4812.4 4818.5 4864.7 4875.3 4790.8 4822.6 4824.8 4838.6 4879.4 4772.1 4937.7 4937.8 4941.7 4991.1 4682.3 4793.6 4797.8 4817.8 4841.0 02:55:22 INFO - PROCESS | 5557 | 02:55:22 INFO - PROCESS | 5557 | [#1] ext.html Cycles:180 Average:44293.29 Median:3443.72 stddev:78972.97 (2293.2%) stddev-sans-first:79126.14 02:55:22 INFO - PROCESS | 5557 | Values: 525.5 530.7 551.2 564.5 581.1 26971.2 36623.8 38397.0 38770.6 42022.2 38610.0 38916.4 38936.6 39008.2 39008.2 7218.5 7377.8 7386.9 7396.7 7396.8 7344.8 7564.1 9315.3 9651.7 9661.3 9482.2 9541.3 9547.5 9547.6 9560.4 9582.8 9661.5 9667.2 9674.6 9680.6 9546.2 9610.5 9619.2 9620.6 9624.3 36939.3 37216.6 37239.6 37248.0 37327.4 2972.5 3082.1 3151.6 3201.5 3377.9 26954.6 27451.9 27571.9 27961.3 28193.0 3433.7 3453.8 3474.2 3505.3 3534.8 231953.0 233496.0 234316.0 234440.8 234654.0 51469.7 51791.0 51882.0 51912.5 51920.7 53512.2 53895.2 53951.7 54049.7 54066.7 14522.4 14927.6 14963.4 14976.5 14977.3 9923.8 10128.4 11539.8 11638.7 11647.4 15255.2 15620.6 15723.6 16151.4 16193.0 5728.1 5804.7 5814.3 5875.2 5899.8 748.8 811.7 887.9 947.1 975.0 26163.2 27120.5 27170.0 27577.2 27600.3 904.0 918.9 940.7 965.6 999.1 14198.0 14362.4 14476.0 14632.7 14695.2 333684.0 335641.0 336582.0 336825.0 338193.0 46940.5 47007.0 47030.8 47074.3 47364.8 1029.2 1111.7 1132.9 1157.4 1207.4 24229.4 25749.4 26066.6 26164.0 27834.9 40013.6 40684.8 40777.8 40875.8 40881.8 319080.0 321506.0 321614.0 321657.0 322756.0 21970.5 22431.9 22816.1 22843.4 24049.2 35017.1 35260.1 35421.8 35513.3 36613.5 29817.0 29962.7 29999.0 30268.8 31218.0 29428.0 29873.0 30342.5 30453.2 30689.4 28583.3 30787.4 31082.2 31127.0 31328.0 25947.7 27771.4 27948.0 28428.3 28478.7 21837.5 22196.6 22585.9 22755.8 22769.3 02:55:22 INFO - PROCESS | 5557 | 02:55:22 INFO - PROCESS | 5557 | [#2] jquery.html Cycles:180 Average:21224.78 Median:5024.01 stddev:50614.39 (1007.4%) stddev-sans-first:50732.09 02:55:22 INFO - PROCESS | 5557 | Values: 342.1 351.4 358.5 365.9 380.5 12206.4 13183.3 15134.8 15680.0 15809.9 15892.4 16016.2 16201.0 16292.6 16423.8 4856.9 4857.1 5085.9 5095.7 5099.9 4964.5 5012.4 5051.6 5055.7 5058.8 5023.5 5024.5 5030.5 5030.8 5032.8 4759.7 4980.6 4986.4 4995.0 4996.3 4464.0 4464.6 4466.2 4467.5 4467.8 19197.1 19284.0 19383.6 19557.8 19793.9 1847.7 1962.7 1963.1 1968.1 1977.3 11839.9 12564.0 12628.3 12866.5 13196.6 1697.9 1716.4 1720.1 1764.1 1817.8 65797.0 66197.7 66256.1 66488.7 66634.3 8608.1 8664.7 8865.5 8886.2 9217.5 12085.6 12095.2 12102.0 12110.2 12146.8 6894.9 7035.2 7218.6 7372.0 7375.3 6972.6 7060.9 7061.5 7131.5 7192.4 5737.7 5863.7 5874.2 5918.9 6063.8 1693.4 1743.8 1745.2 1772.8 1804.1 755.3 794.6 833.9 879.6 914.0 15183.5 15896.8 16200.1 16264.3 16850.7 826.4 826.8 849.5 857.0 860.7 9027.4 9312.1 9504.6 9510.5 9544.2 257918.0 259576.0 260351.0 358262.0 358430.0 72954.3 72980.0 73764.6 74926.6 76307.2 876.7 920.4 941.4 948.6 949.3 14648.1 14971.1 15304.0 15322.2 15667.1 30393.4 34744.8 35718.6 35855.0 36381.5 48893.5 49607.0 49662.8 49708.0 50311.5 6771.4 6844.9 6854.5 6988.2 7002.5 8271.3 9907.6 11059.7 11066.9 11620.7 9320.3 9459.7 9627.8 9669.1 9778.5 9657.5 9878.8 9889.7 9939.3 10078.4 9560.8 9683.1 9771.2 10048.1 10171.7 7055.1 7066.5 7122.8 7230.0 7301.2 8160.3 9651.1 9714.2 9837.4 10010.1 02:55:22 INFO - PROCESS | 5557 | 02:55:22 INFO - PROCESS | 5557 | [#3] mootools.html Cycles:180 Average:4821.26 Median:5134.92 stddev:2656.66 (51.7%) stddev-sans-first:2650.25 02:55:22 INFO - PROCESS | 5557 | Values: 1209.4 1310.7 1315.3 1386.4 1618.1 6190.4 7113.7 7277.9 7298.1 7519.7 7331.8 7374.6 7399.1 7405.1 7416.2 1792.2 2078.0 2104.9 2110.5 2117.7 1871.7 1987.9 2050.0 2054.3 2082.0 2068.3 2075.8 2087.4 2089.4 2090.0 2033.6 2076.4 2077.9 2077.9 2079.1 2064.5 2081.0 2089.8 2090.6 2097.1 7317.0 7361.8 7387.3 7446.0 7477.8 4308.1 4453.2 4468.2 4476.6 4482.2 2598.6 2693.6 2753.1 2759.6 2765.2 846.8 886.6 886.7 901.7 902.1 9593.0 9610.7 9711.2 9729.2 9730.5 3717.5 3814.8 3910.6 3911.8 4120.0 8453.0 8481.4 8483.5 8487.3 8495.4 4349.2 4424.0 4424.8 4448.0 4466.0 3560.9 3673.2 4033.1 4051.0 4061.5 3299.9 3425.6 3500.8 3520.6 3534.3 1113.3 1123.5 1131.3 1140.5 1147.3 830.2 839.9 856.4 860.5 892.8 4959.2 5055.7 5061.2 5104.0 5221.9 400.1 403.7 410.2 410.9 414.9 3493.9 3530.5 3600.4 3618.0 3652.1 8530.6 8787.6 8874.7 8887.3 8907.3 8848.2 8858.4 8863.5 8869.6 8870.5 6653.6 6835.2 6859.4 6905.4 6946.2 4821.3 4836.6 5165.9 5176.9 5312.2 7950.8 7999.9 8077.4 8173.0 8216.3 8117.5 8183.6 8291.8 8350.7 8398.4 5643.3 5799.9 6353.7 6456.9 6533.4 6742.9 6991.0 6994.5 7087.3 7107.2 6332.4 6356.0 6407.1 6608.4 6620.4 6375.6 6431.8 6438.7 6441.5 6473.0 6002.7 6107.1 6132.2 6142.9 6144.2 4416.0 4515.5 4571.9 4577.2 4606.1 4416.5 4452.7 4575.6 4580.7 4758.2 02:55:22 INFO - PROCESS | 5557 | 02:55:22 INFO - PROCESS | 5557 | [#4] prototype.html Cycles:180 Average:4193.34 Median:4717.98 stddev:1171.72 (24.8%) stddev-sans-first:1138.26 02:55:22 INFO - PROCESS | 5557 | Values: 314.3 331.0 332.6 340.1 340.1 4840.3 4879.6 4884.7 4893.3 4898.0 4737.5 4764.9 4817.0 4823.3 4862.7 3627.5 3757.8 3795.0 3803.4 3839.1 3827.3 3841.7 3850.4 3858.4 3862.2 3821.7 3829.4 3829.4 3846.7 3854.7 3674.7 3768.8 3778.7 3829.3 3852.6 3452.9 3459.7 3462.2 3466.0 3516.6 4594.7 4628.7 4644.7 4669.3 4675.3 4314.9 4392.4 4400.2 4404.4 4431.7 4996.3 5007.4 5008.8 5009.0 5033.2 3741.8 3746.4 3748.5 3762.2 3774.1 5143.0 5261.2 5267.9 5283.9 5284.4 3824.2 3834.2 3849.0 3872.6 3889.3 3921.1 3934.8 3935.6 3943.1 3947.1 4366.7 4393.5 4427.8 4434.3 4437.3 4861.5 5037.7 5038.8 5040.2 5077.7 1323.3 1323.3 1330.9 1332.2 1339.7 917.7 946.7 963.1 965.8 967.3 4305.2 4311.8 4417.0 4444.8 4450.1 5175.3 5188.4 5189.1 5199.1 5221.8 4428.5 4445.3 4454.8 4461.4 4487.2 2593.3 2639.0 2641.3 2671.3 2680.0 4720.5 4742.9 4756.6 4757.3 4762.8 4949.7 5164.8 5172.3 5236.3 5240.8 4628.7 4683.6 4687.8 4689.4 4715.5 5038.5 5047.8 5103.5 5110.3 5110.7 4816.1 4996.6 5010.8 5034.0 5035.5 4738.3 4749.3 4773.3 4789.4 4827.6 3846.0 3846.5 3849.3 3851.0 3886.4 5073.2 5114.5 5115.2 5152.5 5163.2 4813.7 4955.9 4960.7 4977.6 5008.4 4955.3 4961.6 4976.3 4994.4 5001.8 4708.9 4841.3 4869.8 4874.5 4945.8 4842.5 4848.9 4927.7 4955.7 4973.8 4835.8 4955.9 4975.1 4981.6 4999.3 02:55:22 INFO - PROCESS | 5557 | 02:55:22 INFO - PROCESS | 5557 | [#5] yui.html Cycles:180 Average:14349.79 Median:460.82 stddev:17266.22 (3746.8%) stddev-sans-first:17283.87 02:55:22 INFO - PROCESS | 5557 | Values: 619.8 628.9 675.4 710.4 741.9 13350.7 14090.0 14095.9 14108.9 14111.2 13075.3 13112.6 13124.0 13148.5 13258.9 618.1 633.7 762.6 768.7 776.0 764.8 783.1 785.2 785.5 785.8 822.5 823.2 823.7 823.9 824.8 650.8 664.7 789.0 816.8 817.8 600.4 604.8 605.2 605.4 605.5 13453.0 13460.4 13469.1 13489.8 13490.3 12974.2 13033.9 13113.2 13197.3 13268.8 11911.9 12034.4 12093.0 12284.4 12310.6 4011.5 4031.2 4065.8 4117.2 4125.4 65684.3 66192.7 67432.3 68217.0 68783.7 9945.3 10031.4 10122.7 10196.6 10238.5 19672.9 19698.5 19702.4 19718.5 19812.0 6621.8 6682.8 6789.3 6794.9 6919.8 3573.2 3601.1 3601.3 3617.0 3640.7 2772.0 2806.0 2807.3 2816.4 2833.7 453.8 460.0 460.7 460.9 469.4 538.8 542.2 543.1 543.3 549.0 7054.8 7400.7 7611.4 7786.8 7815.0 514.1 535.5 550.9 620.4 625.2 3538.7 3911.8 4171.6 4196.0 4220.7 49013.3 50145.2 51987.7 60716.0 62140.7 50600.3 50753.0 51400.7 52478.2 53375.5 45498.5 47865.3 48669.0 48964.3 49325.3 7911.6 8401.6 8475.4 8517.5 8631.9 32821.0 32822.2 32961.8 34323.0 34615.5 40751.4 41006.0 45101.8 46094.3 46484.3 10833.0 10895.6 11082.3 11283.2 11436.6 11833.5 11908.2 12437.9 12438.8 12642.3 11246.2 11609.6 11689.2 11762.9 12509.2 11989.2 12252.8 12303.0 12964.9 13047.5 11717.6 11765.2 11781.0 11785.2 12451.5 9221.4 9229.5 9838.8 9855.9 9892.3 9228.7 9528.0 9536.2 9539.9 9542.3 02:55:22 INFO - PROCESS | 5557 | -------- Summary: end -------- 02:55:22 INFO - PROCESS | 5557 | 02:55:23 INFO - TEST-INFO | 5557: exit 0 02:55:23 INFO - TEST-OK | dromaeo_css | took 1122977ms 02:55:23 INFO - TEST-START | kraken 02:55:23 INFO - operating with platform_type : linux_ 02:55:23 INFO - Initialising browser for kraken test... 02:55:23 INFO - TEST-INFO | started process 5862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYfGcAB/profile http://localhost:32863/getInfo.html) 02:55:27 INFO - PROCESS | 5862 | __metrics Screen width/height:1600/1200 02:55:27 INFO - PROCESS | 5862 | colorDepth:24 02:55:27 INFO - PROCESS | 5862 | Browser inner width/height: 1024/697 02:55:27 INFO - PROCESS | 5862 | __metrics 02:55:28 INFO - PROCESS | 5862 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:55:28 INFO - PROCESS | 5862 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:55:28 INFO - PROCESS | 5862 | console.error: PushService: 02:55:28 INFO - PROCESS | 5862 | stateChangeProcessEnqueue: Error transitioning state 02:55:28 INFO - PROCESS | 5862 | UnknownError 02:55:29 INFO - TEST-INFO | 5862: exit 0 02:55:29 INFO - Browser initialized. 02:55:29 INFO - Running cycle 1/1 for kraken test... 02:55:29 INFO - TEST-INFO | started process 5944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYfGcAB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:55:41 INFO - PROCESS | 5944 | RSS: Main: 174006272 02:55:41 INFO - PROCESS | 5944 | 02:55:44 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32863/tests/kraken/driver.html?testName=audio-beat-detection) 02:55:45 INFO - PROCESS | 5944 | RSS: Main: 235524096 02:55:45 INFO - PROCESS | 5944 | 02:55:48 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32863/tests/kraken/driver.html?testName=audio-dft) 02:55:48 INFO - PROCESS | 5944 | RSS: Main: 217329664 02:55:48 INFO - PROCESS | 5944 | 02:55:52 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32863/tests/kraken/driver.html?testName=audio-fft) 02:55:52 INFO - PROCESS | 5944 | RSS: Main: 300896256 02:55:52 INFO - PROCESS | 5944 | 02:55:54 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32863/tests/kraken/driver.html?testName=audio-oscillator) 02:55:55 INFO - PROCESS | 5944 | RSS: Main: 211238912 02:55:55 INFO - PROCESS | 5944 | 02:55:57 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32863/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:55:58 INFO - PROCESS | 5944 | RSS: Main: 214331392 02:55:58 INFO - PROCESS | 5944 | 02:56:01 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32863/tests/kraken/driver.html?testName=imaging-darkroom) 02:56:02 INFO - PROCESS | 5944 | RSS: Main: 253607936 02:56:02 INFO - PROCESS | 5944 | 02:56:05 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32863/tests/kraken/driver.html?testName=imaging-desaturate) 02:56:06 INFO - PROCESS | 5944 | RSS: Main: 248201216 02:56:06 INFO - PROCESS | 5944 | 02:56:09 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32863/tests/kraken/driver.html?testName=json-parse-financial) 02:56:09 INFO - PROCESS | 5944 | RSS: Main: 249589760 02:56:09 INFO - PROCESS | 5944 | 02:56:11 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32863/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:56:12 INFO - PROCESS | 5944 | RSS: Main: 212869120 02:56:12 INFO - PROCESS | 5944 | 02:56:14 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32863/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:56:14 INFO - PROCESS | 5944 | RSS: Main: 220102656 02:56:14 INFO - PROCESS | 5944 | 02:56:17 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32863/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:56:17 INFO - PROCESS | 5944 | RSS: Main: 224686080 02:56:17 INFO - PROCESS | 5944 | 02:56:20 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:56:21 INFO - PROCESS | 5944 | RSS: Main: 223784960 02:56:21 INFO - PROCESS | 5944 | 02:56:24 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:56:24 INFO - PROCESS | 5944 | RSS: Main: 225898496 02:56:24 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | Cycle 1(1): loaded http://localhost:32863/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32863/tests/kraken/driver.html?testName=ai-astar) 02:56:26 INFO - PROCESS | 5944 | RSS: Main: 279597056 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | __start_tp_report 02:56:26 INFO - PROCESS | 5944 | _x_x_mozilla_page_load 02:56:26 INFO - PROCESS | 5944 | _x_x_mozilla_page_load_details 02:56:26 INFO - PROCESS | 5944 | |i|pagename|runs| 02:56:26 INFO - PROCESS | 5944 | |0;ai-astar;112;116;115;116;116;116;115;114;117;115 02:56:26 INFO - PROCESS | 5944 | |1;audio-beat-detection;164;130;135;173;138;131;132;127;145;138 02:56:26 INFO - PROCESS | 5944 | |2;audio-dft;160;163;161;163;161;162;162;164;163;160 02:56:26 INFO - PROCESS | 5944 | |3;audio-fft;75;75;76;112;76;79;77;76;98;75 02:56:26 INFO - PROCESS | 5944 | |4;audio-oscillator;92;84;110;85;85;84;103;84;84;106 02:56:26 INFO - PROCESS | 5944 | |5;imaging-gaussian-blur;128;129;129;128;127;127;127;128;127;127 02:56:26 INFO - PROCESS | 5944 | |6;imaging-darkroom;149;149;149;149;148;151;150;149;150;147 02:56:26 INFO - PROCESS | 5944 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 02:56:26 INFO - PROCESS | 5944 | |8;json-parse-financial;67;66;66;64;65;65;65;65;65;66 02:56:26 INFO - PROCESS | 5944 | |9;json-stringify-tinderbox;66;66;66;66;67;67;66;65;66;66 02:56:26 INFO - PROCESS | 5944 | |10;stanford-crypto-aes;89;89;92;88;95;88;94;95;124;87 02:56:26 INFO - PROCESS | 5944 | |11;stanford-crypto-ccm;143;143;144;140;151;140;143;139;163;147 02:56:26 INFO - PROCESS | 5944 | |12;stanford-crypto-pbkdf2;184;178;181;180;178;177;180;181;180;177 02:56:26 INFO - PROCESS | 5944 | |13;stanford-crypto-sha256-iterative;70;72;69;67;67;68;69;67;67;67 02:56:26 INFO - PROCESS | 5944 | __end_tp_report 02:56:26 INFO - PROCESS | 5944 | __start_cc_report 02:56:26 INFO - PROCESS | 5944 | _x_x_mozilla_cycle_collect,1957 02:56:26 INFO - PROCESS | 5944 | __end_cc_report 02:56:26 INFO - PROCESS | 5944 | __startTimestamp1481367386946__endTimestamp 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | ------- Summary: start ------- 02:56:26 INFO - PROCESS | 5944 | Number of tests: 14 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:1.40 (1.2%) stddev-sans-first:0.88 02:56:26 INFO - PROCESS | 5944 | Values: 112.0 116.0 115.0 116.0 116.0 116.0 115.0 114.0 117.0 115.0 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:138.00 stddev:15.35 (11.1%) stddev-sans-first:13.91 02:56:26 INFO - PROCESS | 5944 | Values: 164.0 130.0 135.0 173.0 138.0 131.0 132.0 127.0 145.0 138.0 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.37 (0.8%) stddev-sans-first:1.27 02:56:26 INFO - PROCESS | 5944 | Values: 160.0 163.0 161.0 163.0 161.0 162.0 162.0 164.0 163.0 160.0 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.67 (16.7%) stddev-sans-first:13.19 02:56:26 INFO - PROCESS | 5944 | Values: 75.0 75.0 76.0 112.0 76.0 79.0 77.0 76.0 98.0 75.0 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:84.00 stddev:10.51 (12.5%) stddev-sans-first:11.15 02:56:26 INFO - PROCESS | 5944 | Values: 92.0 84.0 110.0 85.0 85.0 84.0 103.0 84.0 84.0 106.0 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#5] imaging-gaussian-blur Cycles:10 Average:127.70 Median:128.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 02:56:26 INFO - PROCESS | 5944 | Values: 128.0 129.0 129.0 128.0 127.0 127.0 127.0 128.0 127.0 127.0 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 02:56:26 INFO - PROCESS | 5944 | Values: 149.0 149.0 149.0 149.0 148.0 151.0 150.0 149.0 150.0 147.0 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:56:26 INFO - PROCESS | 5944 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.67 02:56:26 INFO - PROCESS | 5944 | Values: 67.0 66.0 66.0 64.0 65.0 65.0 65.0 65.0 65.0 66.0 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 02:56:26 INFO - PROCESS | 5944 | Values: 66.0 66.0 66.0 66.0 67.0 67.0 66.0 65.0 66.0 66.0 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#10] stanford-crypto-aes Cycles:10 Average:94.10 Median:90.50 stddev:10.94 (12.1%) stddev-sans-first:11.45 02:56:26 INFO - PROCESS | 5944 | Values: 89.0 89.0 92.0 88.0 95.0 88.0 94.0 95.0 124.0 87.0 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:143.50 stddev:7.17 (5.0%) stddev-sans-first:7.55 02:56:26 INFO - PROCESS | 5944 | Values: 143.0 143.0 144.0 140.0 151.0 140.0 143.0 139.0 163.0 147.0 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:180.00 stddev:2.17 (1.2%) stddev-sans-first:1.62 02:56:26 INFO - PROCESS | 5944 | Values: 184.0 178.0 181.0 180.0 178.0 177.0 180.0 181.0 180.0 177.0 02:56:26 INFO - PROCESS | 5944 | 02:56:26 INFO - PROCESS | 5944 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.70 (2.5%) stddev-sans-first:1.69 02:56:26 INFO - PROCESS | 5944 | Values: 70.0 72.0 69.0 67.0 67.0 68.0 69.0 67.0 67.0 67.0 02:56:26 INFO - PROCESS | 5944 | -------- Summary: end -------- 02:56:26 INFO - PROCESS | 5944 | 02:56:28 INFO - TEST-INFO | 5944: exit 0 02:56:28 INFO - TEST-OK | kraken | took 64993ms 02:56:28 INFO - SUITE-END | took 1187s 02:56:28 INFO - Completed test suite (00:19:48) 02:56:28 INFO - javascript benchmark 02:56:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2569.71733109358, 2587.6118582212666, 2597.6363309136714, 2625.1861922803932, 2637.3142982824447, 4531.909361812762, 4570.542945705428, 4612.723236605806, 4687.343771871936, 4708.411448568929, 4613.354130421735, 4678.5789278964885, 4711.623070154388, 4741.668083234175, 4808.639352048593, 4248.97875510622, 4264.573542645726, 4294.334378171388, 4322.675799315049, 4385.780710964455, 3976.960230397688, 4301.462317210348, 4394.450693663292, 4428.955710442902, 4481.865544033684, 4208.789560521992, 4244.830206791725, 4383.211022016036, 4419.558044195587, 4436.911261774762, 4279.0, 4279.935800962957, 4302.806373713191, 4305.892352691177, 4310.3103503439615, 4275.978620106911, 4315.870523884289, 4316.093620339732, 4376.518582955872, 4384.0, 4684.742339171345, 4718.858434246944, 4727.976360118178, 4752.025834703877, 4772.451168115642, 4959.380077490314, 4990.975045124787, 5032.6477146599755, 5043.142665746832, 5047.0915235257635, 4962.255661650745, 5012.147934851084, 5019.824306149304, 5035.043341765053, 5094.261332106824, 4696.600788932945, 4700.341952126705, 4701.6003639690325, 4705.388299521041, 4749.857504274877, 5117.309163262987, 5119.829504996791, 5121.385433747974, 5128.538431541105, 5166.9224961625605, 4817.518248175154, 4824.445188803263, 4872.342233798463, 4875.268709693574, 4875.609951203895, 4956.900861982812, 4963.10664080469, 4963.677360971526, 4966.081274964144, 4967.031428871408, 4890.144224760653, 4919.680220785637, 4929.654924155347, 4930.901381972412, 4931.556159945622, 4915.975420122948, 4925.581325587365, 4928.852134435972, 4931.457539670633, 4940.604751619933, 4301.913961720748, 4304.3543468479975, 4305.203537345601, 4306.138772245501, 4311.504177019683, 3722.813859307024, 3760.8871733848027, 3765.322241996467, 3824.330742120118, 3859.4403811447746, 4332.328489084197, 4334.783260836945, 4338.783060846945, 4364.039911219526, 4378.540253273361, 5050.873728156826, 5086.618503612244, 5093.2360145977655, 5094.0, 5140.280360749498, 4179.519355274121, 4216.9789151054665, 4219.177260434247, 4265.338872474771, 4351.782410879443, 4483.708558943658, 4557.316402539645, 4560.908781824345, 4575.428071491064, 4610.124076425468, 4690.906181876343, 4707.693999889996, 4723.409573803275, 4733.763311834326, 4779.737114458599, 5083.085044691843, 5084.3898732152375, 5094.388673359221, 5096.694198348111, 5143.61422893277, 4551.06703125865, 4593.150267200579, 4603.884902877455, 4607.216773148506, 4618.03021365517, 4897.583705385082, 4916.287138364845, 4918.286848407032, 4964.379452568429, 4967.230079337708, 4972.2790195422185, 4985.8005679772405, 4994.900101998012, 4996.925046124384, 5046.116929537389, 4735.550122738335, 4770.379850619397, 4773.451053128796, 4810.278458231293, 4858.878528036827, 4810.182269014206, 4812.398450193726, 4818.518148185153, 4864.659473836798, 4875.268709693574, 4790.808367665394, 4822.638302127425, 4824.807007719652, 4838.612910967185, 4879.414470263591, 4772.093302272557, 4937.728424936663, 4937.8271760488215, 4941.703497790144, 4991.126552853309, 4682.321063445713, 4793.616510679207, 4797.784099715591, 4817.759112044454, 4841.0], "value": 4595.5927836596975, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.5401523666792, 530.7134147560315, 551.2310327093702, 564.4947771744289, 581.128307538692, 26971.190864274053, 36623.81688091559, 38396.99999999996, 38770.61229387705, 42022.159556808845, 38610.0, 38916.41625375614, 38936.61063389365, 39008.21983560327, 39008.21983560334, 7218.458615603825, 7377.77866664001, 7386.852262954764, 7396.741114061009, 7396.815079622998, 7344.779656610311, 7564.130125035636, 9315.276673815366, 9651.71044868655, 9661.275404344668, 9482.241420686363, 9541.33210675253, 9547.522623868814, 9547.570359333846, 9560.378575392611, 9582.760430989247, 9661.46861922594, 9667.226621870233, 9674.56464459101, 9680.612775488971, 9546.236301095896, 9610.519474026341, 9619.230461563058, 9620.615175392975, 9624.326297159201, 36939.26121477556, 37216.627833721584, 37239.627603723886, 37248.0, 37327.4400883987, 2972.524396096614, 3082.1061892051503, 3151.5745374374396, 3201.4557525220766, 3377.8986630401128, 26954.5956810648, 27451.862740686367, 27571.86214068937, 27961.300967475774, 28193.0, 3433.6738009889023, 3453.7755045921936, 3474.2356681530277, 3505.2814173094453, 3534.7525673202886, 231953.0, 233496.0, 234316.0, 234440.82779586164, 234654.0, 51469.742651286506, 51791.0, 51882.0, 51912.48087519152, 51920.74039629778, 53512.19731704028, 53895.19157212645, 53951.730241348545, 54049.72975135099, 54066.72966635141, 14522.419103235752, 14927.552173434815, 14963.401463941538, 14976.475823346349, 14977.326020329112, 9923.751906202258, 10128.430093335544, 11539.826902596467, 11638.6508404748, 11647.359395233174, 15255.160966146968, 15620.609484762972, 15723.606909827346, 16151.434699785452, 16193.028418294705, 5728.140778883201, 5804.709764511842, 5814.319158600967, 5875.20684707559, 5899.76400943966, 748.8352562436255, 811.703728139225, 887.9112088791069, 947.0766003146877, 974.9561269742878, 26163.215103546925, 27120.457590848073, 27170.0, 27577.17268481949, 27600.309992250353, 903.9954800225956, 918.9035151309016, 940.6519587752439, 965.5703212070562, 999.14073896449, 14198.0, 14362.353694083791, 14476.0, 14632.707345853023, 14695.191764453059, 333684.0, 335641.0, 336582.0, 336825.0, 338193.0, 46940.5305946943, 47007.0, 47030.76484617624, 47074.293885591745, 47364.7631761839, 1029.2332212501733, 1111.7053980694961, 1132.8753837077916, 1157.3576664950697, 1207.4144040140525, 24229.394265142808, 25749.3562660935, 26066.60900086538, 26164.0, 27834.87632720798, 40013.599864000986, 40684.79657601812, 40777.796111019255, 40875.7956210217, 40881.795591023045, 319080.0, 321506.0, 321614.0, 321657.0, 322756.0, 21970.45073873166, 22431.887840560692, 22816.087356505555, 22843.428914277276, 24049.158279460135, 35017.124571885906, 35260.11849703778, 35421.82289088538, 35513.28973420569, 36613.450798238584, 29817.0, 29962.700372996864, 29999.0, 30268.84865575658, 31218.0, 29428.0, 29873.0, 30342.54486182665, 30453.23866903345, 30689.38621227518, 28583.28541786472, 30787.384252315278, 31082.22294442657, 31127.0, 31328.0, 25947.740522595286, 27771.44457110887, 27948.0, 28428.289292767848, 28478.715212847605, 21837.454063648536, 22196.556068878854, 22585.887070564542, 22755.772442275364, 22769.316920492412], "value": 16825.811329352015, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.06391822285866, 351.4464718069042, 358.53211558915615, 365.8975486863679, 380.48121436093066, 12206.389680515971, 13183.340832958362, 15134.772978405334, 15680.0, 15809.920950395232, 15892.364305427798, 16016.19919004051, 16201.0, 16292.592685182877, 16423.83576164238, 4856.902861942768, 4857.101436234308, 5085.949140508603, 5095.694258344512, 5099.923501147486, 4964.453910069889, 5012.448630650625, 5051.621128415383, 5055.6713813602, 5058.772355244005, 5023.497650234984, 5024.5226703463295, 5030.522100400474, 5030.7987680492915, 5032.84901452957, 4759.666823322369, 4980.601551875841, 4986.4265609455015, 4995.025969935864, 4996.300517927457, 4464.0, 4464.620507256887, 4466.235836844428, 4467.463904331501, 4467.843625473125, 19197.136128874095, 19284.0, 19383.612327753508, 19557.804421955883, 19793.9010304949, 1847.6951303034982, 1962.705594160873, 1963.0871644685146, 1968.0651690447066, 1977.2881762565464, 11839.94080029603, 12564.0, 12628.305443200621, 12866.485340586365, 13196.60410187696, 1697.8981261124372, 1716.4078392954411, 1720.131333676498, 1764.1267572551542, 1817.8363947244811, 65797.0, 66197.66901165512, 66256.08006438699, 66488.66755666239, 66634.3336566633, 8608.139186081467, 8664.653413863502, 8865.512396818236, 8886.155815197546, 9217.493037882981, 12085.637430877088, 12095.213811102427, 12102.0, 12110.212836165798, 12146.817797732865, 6894.896576551356, 7035.1909530404655, 7218.6390680465765, 7372.0, 7375.336219740249, 6972.581645101209, 7060.940858871108, 7061.540999834994, 7131.500794944304, 7192.388646965067, 5737.741801618937, 5863.70681465925, 5874.236349274567, 5918.911216331759, 6063.787767428119, 1693.3734518228089, 1743.8168992255885, 1745.1972092837436, 1772.7735521351274, 1804.115983168238, 755.3088923634813, 794.5709316968772, 833.9041010283895, 879.6041781198486, 914.0265617117748, 15183.468578599917, 15896.841031589767, 16200.108994005208, 16264.268107935171, 16850.747238791428, 826.3843436639742, 826.7850358906727, 849.4945507423197, 856.9742907712779, 860.655737704923, 9027.36808423404, 9312.115349041831, 9504.572294246775, 9510.524473776284, 9544.188743956702, 257918.0, 259576.0, 260351.0, 358262.0, 358430.0, 72954.2704572958, 72980.0, 73764.63117684377, 74926.62536687282, 76307.23692763002, 876.6931573949067, 920.3787443475761, 941.4163218804385, 948.6063283737171, 949.292776881228, 14648.12111273327, 14971.101733896001, 15304.0, 15322.233888305764, 15667.138307393203, 30393.392132157674, 34744.82627586846, 35718.64281357153, 35855.0, 36381.454278185316, 48893.51106489032, 49607.0, 49662.75168624134, 49708.0, 50311.49688503068, 6771.356721111487, 6844.897326540006, 6854.451643868579, 6988.161420629353, 7002.544834585736, 8271.296939760188, 9907.603695852085, 11059.72350691239, 11066.944665276622, 11620.6513804586, 9320.254379649476, 9459.668911588062, 9627.759306017406, 9669.129778319984, 9778.462184579916, 9657.46883921363, 9878.802423951625, 9889.703308900744, 9939.254555908481, 10078.395296282246, 9560.808783824146, 9683.128518433376, 9771.218302535923, 10048.145907597936, 10171.7457063574, 7055.082839230867, 7066.540674856118, 7122.821929451805, 7229.963850180716, 7301.196868344372, 8160.347172226327, 9651.083147101013, 9714.174295184988, 9837.360571562825, 10010.14913732341], "value": 7879.665740307797, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1209.3529961470615, 1310.685435495481, 1315.2568798628774, 1386.431563059146, 1618.1100394782875, 6190.411910868472, 7113.715451381945, 7277.927220727798, 7298.124225092996, 7519.6616152273145, 7331.816704582375, 7374.557526548411, 7399.149097853749, 7405.074365704287, 7416.22129676383, 1792.2024699008946, 2077.9896100519513, 2104.9473763155966, 2110.5145816462145, 2117.650587653043, 1871.681814091601, 1987.85091118166, 2049.9692504612444, 2054.291269512016, 2082.0422605601443, 2068.276103363818, 2075.7716651168357, 2087.3633541769755, 2089.3731880435885, 2090.0, 2033.6339458897392, 2076.439361372421, 2077.885716285619, 2077.9064942077644, 2079.054030416157, 2064.494198921259, 2080.9687854682193, 2089.7701252862325, 2090.613236551243, 2097.129691178159, 7317.0, 7361.779146625609, 7387.261273872624, 7445.9627701861145, 7477.813054673622, 4308.116836048603, 4453.242948698697, 4468.218061839165, 4476.6418686505, 4482.21561226784, 2598.610208468726, 2693.5690289553772, 2753.105240796749, 2759.558470644707, 2765.1566272286946, 846.8179341441559, 886.5567216391804, 886.7384121684119, 901.6753968571309, 902.0798785239019, 9593.0, 9610.711678649652, 9711.223102151811, 9729.173020293283, 9730.513474326255, 3717.4795528626014, 3814.771113733185, 3910.589388114264, 3911.8239679214503, 4120.0, 8453.0, 8481.363897707697, 8483.533405662625, 8487.278581320534, 8495.405321627426, 4349.173657005159, 4423.955760442419, 4424.756638384855, 4448.043670610834, 4465.955340446619, 3560.946585801215, 3673.173535954389, 4033.1127152026506, 4051.0277533391773, 4061.5126184858004, 3299.851506682205, 3425.5718035245595, 3500.789952602852, 3520.612732599412, 3534.3108093921437, 1113.2986218682179, 1123.4888125902694, 1131.2533727739653, 1140.509580880213, 1147.3460127727114, 830.1781236575747, 839.9454035487673, 856.3705676327894, 860.4708104515678, 892.7723430525175, 4959.231319145466, 5055.6713813602, 5061.164907790247, 5103.974480127576, 5221.921671174935, 400.1157442053037, 403.73958796576045, 410.20420384454064, 410.86030749545296, 414.86309517859036, 3493.9126521837156, 3530.505729197914, 3600.405933021022, 3617.963820361763, 3652.0687224757517, 8530.573471326408, 8787.648494060166, 8874.689385871592, 8887.333449991147, 8907.331950103768, 8848.20366167048, 8858.379913406128, 8863.468191908507, 8869.64521419136, 8870.467771933576, 6653.600783952978, 6835.179778426521, 6859.382655561023, 6905.447564194852, 6946.2011868635755, 4821.349117869183, 4836.613070954245, 5165.870853228549, 5176.870578235575, 5312.229726689531, 7950.801229969297, 7999.880001800094, 8077.434579579373, 8173.0, 8216.301614362847, 8117.472364296302, 8183.631736571988, 8291.83416331682, 8350.665973361241, 8398.370122240734, 5643.322801263875, 5799.913001305068, 6353.7140828661895, 6456.9354306456335, 6533.41199292066, 6742.86514269702, 6991.021257023919, 6994.510384273052, 7087.255838136922, 7107.182673992557, 6332.398422149889, 6356.046593011085, 6407.1350367701625, 6608.372204640552, 6620.437262832521, 6375.585586936834, 6431.839204019937, 6438.678066096582, 6441.5490915635455, 6473.0, 6002.669853158118, 6107.144999700135, 6132.233470816148, 6142.938570614416, 6144.2319710036245, 4416.0, 4515.458145022619, 4571.931421028754, 4577.198990176772, 4606.055758569418, 4416.492103408149, 4452.732836029719, 4575.6339492839825, 4580.656450766272, 4758.214894542501], "value": 3846.5385681972066, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.30224900720395, 330.95697559317284, 332.5693227270687, 340.0614304519526, 340.06821309611655, 4840.298156767271, 4879.560839524442, 4884.658073934826, 4893.29047288143, 4897.975510122454, 4737.549932756391, 4764.856434455732, 4816.951830481694, 4823.348847905531, 4862.7325497097645, 3627.4740162676394, 3757.7557458765227, 3794.9810250948844, 3803.3724435468116, 3839.1361943562615, 3827.349350610389, 3841.654251117399, 3850.4416859555486, 3858.401947698111, 3862.1889403225355, 3821.675157611606, 3829.3681542545446, 3829.4490731253886, 3846.653801157895, 3854.691624670034, 3674.724395670322, 3768.7550309230087, 3778.678812300958, 3829.253295607358, 3852.57621661617, 3452.879149229765, 3459.7232221422228, 3462.1690794209208, 3466.0, 3516.6307537708685, 4594.724316541018, 4628.722276663411, 4644.674872758875, 4669.299605059235, 4675.251959686468, 4314.856563010805, 4392.407025051609, 4400.163968845941, 4404.427424434803, 4431.689781715281, 4996.325496058058, 5007.4241462231585, 5008.824691135793, 5009.048280826668, 5033.219850923113, 3741.7567858089137, 3746.3818469952425, 3748.463130116639, 3762.2099359134613, 3774.0942173878348, 5143.0, 5261.159353671841, 5267.947320526784, 5283.947160528384, 5284.4187139414635, 3824.2160357126722, 3834.2331533693373, 3848.9807550962064, 3872.5740168581433, 3889.3470275133523, 3921.058945852975, 3934.7639141651593, 3935.6225321137945, 3943.1127996200626, 3947.072437977073, 4366.694331396835, 4393.494748103945, 4427.8228870844805, 4434.268345722984, 4437.291642717512, 4861.4895435978715, 5037.722925239147, 5038.798448062036, 5040.243963405518, 5077.720725360066, 1323.2655875988726, 1323.3118778235264, 1330.8935285177163, 1332.187365706918, 1339.71196192819, 917.6831247160346, 946.7159852044359, 963.1411376044301, 965.7730433348157, 967.327707243459, 4305.201618947709, 4311.762853043113, 4416.9779151104685, 4444.777761111932, 4450.109978004347, 5175.275461435402, 5188.377394712583, 5189.117849965515, 5199.1161502544655, 5221.817236396784, 4428.512863585003, 4445.2887537993765, 4454.799534020977, 4461.420015397977, 4487.192305384997, 2593.2738833126755, 2638.9736102639113, 2641.339665083729, 2671.252049426164, 2679.9682122383024, 4720.480747117815, 4742.881427964259, 4756.575265808612, 4757.310190022427, 4762.809487620457, 4949.727764972961, 5164.7934082636275, 5172.301739265151, 5236.345456817898, 5240.816571419982, 4628.652851036119, 4683.625309975126, 4687.835925742583, 4689.413823272091, 4715.481297057389, 5038.496150384932, 5047.823326183566, 5103.464136265638, 5110.310108135354, 5110.744462776772, 4816.133096042746, 4996.550310472075, 5010.799568017239, 5033.974830125826, 5035.521625445577, 4738.265568836836, 4749.3113498541825, 4773.331733557374, 4789.353437285922, 4827.565519103297, 3845.9807700961314, 3846.4614953907035, 3849.287881741887, 3851.017990412427, 3886.378179491268, 5073.242576227984, 5114.488551144856, 5115.232715092766, 5152.510511501401, 5163.173892177234, 4813.748425409349, 4955.851324460272, 4960.727160006234, 4977.626677999092, 5008.373953255843, 4955.331030311006, 4961.5534601886, 4976.253561965734, 4994.401791426709, 5001.799928002984, 4708.858734237979, 4841.273808928689, 4869.756512174448, 4874.53691899269, 4945.802167913387, 4842.491538388418, 4848.866498740543, 4927.728974906415, 4955.677880937727, 4973.801047958041, 4835.830745923876, 4955.925661115159, 4975.129352363394, 4981.551660350586, 4999.325091112799], "value": 3834.6464030182638, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.8171539395878, 628.8836565235432, 675.362708622828, 710.3677726823125, 741.9220981796908, 13350.732985340288, 14090.0, 14095.859041409596, 14108.858911410884, 14111.223882686436, 13075.28085955272, 13112.606621801362, 13124.0, 13148.539801106963, 13258.867411325884, 618.1006635345584, 633.7021599848064, 762.5500954436881, 768.7040489411589, 776.022212012865, 764.8317370178552, 783.1033466680648, 785.2461636828623, 785.4933567848734, 785.7564155111905, 822.5352675738219, 823.238504383446, 823.7405217356544, 823.9093699693029, 824.8102936324619, 650.7592190889354, 664.7473959895257, 789.0, 816.7835523586255, 817.7710241132493, 600.3726106219011, 604.8366940925926, 605.2283338743093, 605.3613437823095, 605.4702135631322, 13453.0, 13460.394282257323, 13469.12450690702, 13489.797653035212, 13490.258035808027, 12974.156679815782, 13033.86966130336, 13113.213207207502, 13197.27414992175, 13268.800967985488, 11911.880881191164, 12034.398280086049, 12093.0, 12284.385780711018, 12310.630681079581, 4011.538673052607, 4031.153457773871, 4065.837366505366, 4117.1765646870745, 4125.360569111793, 65684.3431565683, 66192.66903665499, 67432.32567674358, 68217.0, 68783.65608171978, 9945.254105942084, 10031.398116113056, 10122.746931326628, 10196.592136314464, 10238.488075596191, 19672.901635492017, 19698.507537311394, 19702.40892773219, 19718.507037324183, 19812.0, 6621.801345959629, 6682.83292917681, 6789.321067893171, 6794.8641027180165, 6919.792406227822, 3573.2317551726505, 3601.0637234319265, 3601.2977469393218, 3617.04148400674, 3640.690541303966, 2771.9584206236923, 2805.985970070137, 2807.2560771395597, 2816.4367126574357, 2833.744962953303, 453.77991674038066, 460.0201570654485, 460.7005446459761, 460.9446866375989, 469.36869909971034, 538.7662253439657, 542.2056686953553, 543.1445473379364, 543.2584522127268, 548.9670619762827, 7054.75308364215, 7400.666969986363, 7611.3530349919765, 7786.805329866798, 7815.0, 514.0797971630739, 535.5394360849666, 550.8540236837241, 620.3920158244855, 625.2340882419, 3538.716902647782, 3911.765294082364, 4171.645410140111, 4195.97902010488, 4220.662347012231, 49013.26480102801, 50145.2362025607, 51987.74006129945, 60716.0, 62140.689296554134, 50600.349912521866, 50753.0, 51400.74299628478, 52478.21282680763, 53375.466245337826, 45498.545014550094, 47865.28202076902, 48669.0, 48964.26553601699, 49325.26012109821, 7911.643976020978, 8401.579921004048, 8475.449095808754, 8517.531535765593, 8631.91368086311, 32821.0, 32822.179445514055, 32961.83519082389, 34323.0, 34615.480767788, 40751.388729168495, 41005.974850628976, 45101.77449112733, 46094.30858537058, 46484.30273545967, 10833.0, 10895.618653347095, 11082.279651822606, 11283.153763467937, 11436.599719010128, 11833.46749396262, 11908.225965312227, 12437.93781031089, 12438.751224975269, 12642.30467324306, 11246.212765106364, 11609.593664221711, 11689.240199387013, 11762.94118529402, 12509.186902851285, 11989.160758746804, 12252.75494490123, 12303.0, 12964.870351296744, 13047.478100876238, 11717.589884354007, 11765.235259708092, 11781.0, 11785.175037747274, 12451.501939922664, 9221.446713197229, 9229.538523073685, 9838.803223935338, 9855.852162217716, 9892.258080643836, 9228.676996305097, 9527.952360238154, 9536.23710103204, 9539.904600953902, 9542.284328675238], "value": 6194.57105316677, "unit": "score"}], "name": "dromaeo_css", "value": 6179.409838761831, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 115.0, 116.0, 116.0, 116.0, 115.0, 114.0, 117.0, 115.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 130.0, 135.0, 173.0, 138.0, 131.0, 132.0, 127.0, 145.0, 138.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 161.0, 163.0, 161.0, 162.0, 162.0, 164.0, 163.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 112.0, 76.0, 79.0, 77.0, 76.0, 98.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 84.0, 110.0, 85.0, 85.0, 84.0, 103.0, 84.0, 84.0, 106.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 129.0, 129.0, 128.0, 127.0, 127.0, 127.0, 128.0, 127.0, 127.0], "value": 127.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 149.0, 148.0, 151.0, 150.0, 149.0, 150.0, 147.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 65.0, 66.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 92.0, 88.0, 95.0, 88.0, 94.0, 95.0, 124.0, 87.0], "value": 94.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 143.0, 144.0, 140.0, 151.0, 140.0, 143.0, 139.0, 163.0, 147.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 178.0, 181.0, 180.0, 178.0, 177.0, 180.0, 181.0, 180.0, 177.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 69.0, 67.0, 67.0, 68.0, 69.0, 67.0, 67.0, 67.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1582.6999999999998, "alertThreshold": 2.0}]} 02:56:28 INFO - Return code: 0 02:56:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:56:28 INFO - # TBPL SUCCESS # 02:56:28 INFO - Running post-action listener: _resource_record_post_action 02:56:28 INFO - [mozharness: 2016-12-10 10:56:28.768567Z] Finished run-tests step (success) 02:56:28 INFO - Running post-run listener: _resource_record_post_run 02:56:28 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 499712; Write bytes: 392904704; Read time: 52; Write time: 238144 02:56:28 INFO - TinderboxPrint: CPU usage
13.2% 02:56:28 INFO - TinderboxPrint: I/O read bytes / time
499,712 / 52 02:56:28 INFO - TinderboxPrint: I/O write bytes / time
392,904,704 / 238,144 02:56:28 INFO - TinderboxPrint: CPU idle
8,345.3 (86.8%) 02:56:28 INFO - TinderboxPrint: CPU user
1,218.6 (12.7%) 02:56:28 INFO - TinderboxPrint: Swap in / out
0 / 0 02:56:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99786752; Read time: 0; Write time: 67636 02:56:28 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 495616; Write bytes: 293117952; Read time: 48; Write time: 170508 02:56:29 INFO - Running post-run listener: _upload_blobber_files 02:56:29 INFO - Blob upload gear active. 02:56:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:56:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:56:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:56:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:56:29 INFO - (blobuploader) - INFO - Open directory for files ... 02:56:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:56:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:56:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:32 INFO - (blobuploader) - INFO - Done attempting. 02:56:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:56:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:56:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:32 INFO - (blobuploader) - INFO - Done attempting. 02:56:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:56:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:56:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:37 INFO - (blobuploader) - INFO - Done attempting. 02:56:37 INFO - (blobuploader) - INFO - Iteration through files over. 02:56:37 INFO - Return code: 0 02:56:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:56:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:56:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/38f475706502c3705c91e9072c348eb2c102b56f266d544f1048c06048c4ef0bbac1e90f85a55f561a1dfc21fb0d08aed0803caca8cf7a41212f1a8d4e6c3141", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/791fc2a6380a77b04a9b4b4cb9538a5aea41cfa31215f3f08c725f72e483207ee63c3ea4f90d74eb7a3df8ca598c9926f746d150eaec9055310935be235ac45a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/584be95983e9a0700c55ee30858f205b6197a706b909a757be81845286bf96b5ac362d9263843c40ee061f25a9b4e4212250fcbc4d64241a284c39c5e0c1a211"} 02:56:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:56:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:56:37 INFO - Contents: 02:56:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/38f475706502c3705c91e9072c348eb2c102b56f266d544f1048c06048c4ef0bbac1e90f85a55f561a1dfc21fb0d08aed0803caca8cf7a41212f1a8d4e6c3141", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/791fc2a6380a77b04a9b4b4cb9538a5aea41cfa31215f3f08c725f72e483207ee63c3ea4f90d74eb7a3df8ca598c9926f746d150eaec9055310935be235ac45a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/584be95983e9a0700c55ee30858f205b6197a706b909a757be81845286bf96b5ac362d9263843c40ee061f25a9b4e4212250fcbc4d64241a284c39c5e0c1a211"} 02:56:37 INFO - Running post-run listener: copy_logs_to_upload_dir 02:56:37 INFO - Copying logs to upload dir... 02:56:37 INFO - mkdir: /builds/slave/test/build/upload/logs 02:56:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.108385 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-12-10 02:56:37.469119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-10 02:56:37.473002) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/38f475706502c3705c91e9072c348eb2c102b56f266d544f1048c06048c4ef0bbac1e90f85a55f561a1dfc21fb0d08aed0803caca8cf7a41212f1a8d4e6c3141", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/791fc2a6380a77b04a9b4b4cb9538a5aea41cfa31215f3f08c725f72e483207ee63c3ea4f90d74eb7a3df8ca598c9926f746d150eaec9055310935be235ac45a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/584be95983e9a0700c55ee30858f205b6197a706b909a757be81845286bf96b5ac362d9263843c40ee061f25a9b4e4212250fcbc4d64241a284c39c5e0c1a211"} build_url:https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/RIp1CLhmSoCmt_dpfz81Bw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/38f475706502c3705c91e9072c348eb2c102b56f266d544f1048c06048c4ef0bbac1e90f85a55f561a1dfc21fb0d08aed0803caca8cf7a41212f1a8d4e6c3141", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/791fc2a6380a77b04a9b4b4cb9538a5aea41cfa31215f3f08c725f72e483207ee63c3ea4f90d74eb7a3df8ca598c9926f746d150eaec9055310935be235ac45a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/584be95983e9a0700c55ee30858f205b6197a706b909a757be81845286bf96b5ac362d9263843c40ee061f25a9b4e4212250fcbc4d64241a284c39c5e0c1a211"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-10 02:56:37.497893) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 02:56:37.498297) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1481366142.503161-808931615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-10 02:56:37.581606) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-10 02:56:37.581917) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-10 02:56:37.582194) ========= ========= Total master_lag: 0.17 =========