builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1482134276.37 results: success (0) buildid: 20161218230638 builduid: 33e68f8dfb9948aabb913b39e16cb0bc revision: f50d8d3977f82b6161a2561b3b07f3fc45d65cd3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-18 23:57:56.374809) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-18 23:57:56.375154) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-18 23:57:56.375476) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-18 23:57:56.394741) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 23:57:56.394988) ========= 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=6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-18 23:57:57-- 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% 221M=0s 2016-12-18 23:57:57 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100908 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 23:57:56.508826) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 23:57:56.509105) ========= 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=6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014768 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 23:57:56.558849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-18 23:57:56.559147) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev f50d8d3977f82b6161a2561b3b07f3fc45d65cd3 --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 f50d8d3977f82b6161a2561b3b07f3fc45d65cd3 --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=6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-18 23:57:57,743 truncating revision to first 12 chars 2016-12-18 23:57:57,743 Setting DEBUG logging. 2016-12-18 23:57:57,743 attempt 1/10 2016-12-18 23:57:57,743 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/f50d8d3977f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-18 23:57:58,988 unpacking tar archive at: graphics-f50d8d3977f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.559554 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-18 23:57:58.131371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-18 23:57:58.131698) ========= script_repo_revision: f50d8d3977f82b6161a2561b3b07f3fc45d65cd3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-18 23:57:58.132160) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-18 23:57:58.132612) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-18 23:57:58.141095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-18 23:57:58.141435) ========= /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=6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:57:59 INFO - MultiFileLogger online at 20161218 23:57:59 in /builds/slave/test 23:57:59 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 23:57:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:57:59 INFO - {'append_to_log': False, 23:57:59 INFO - 'base_work_dir': '/builds/slave/test', 23:57:59 INFO - 'blob_upload_branch': 'Graphics', 23:57:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:57:59 INFO - 'branch': 'Graphics', 23:57:59 INFO - 'buildbot_json_path': 'buildprops.json', 23:57:59 INFO - 'config_files': ('talos/linux_config.py',), 23:57:59 INFO - 'default_actions': ('clobber', 23:57:59 INFO - 'read-buildbot-config', 23:57:59 INFO - 'download-and-extract', 23:57:59 INFO - 'populate-webroot', 23:57:59 INFO - 'create-virtualenv', 23:57:59 INFO - 'install', 23:57:59 INFO - 'run-tests'), 23:57:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:57:59 INFO - 'download_minidump_stackwalk': True, 23:57:59 INFO - 'download_symbols': 'ondemand', 23:57:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:57:59 INFO - 'tooltool.py': '/tools/tooltool.py', 23:57:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:57:59 INFO - '/tools/misc-python/virtualenv.py')}, 23:57:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:57:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:57:59 INFO - 'installer_path': 'installer.exe', 23:57:59 INFO - 'log_level': 'info', 23:57:59 INFO - 'log_name': 'talos', 23:57:59 INFO - 'log_to_console': True, 23:57:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:57:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:57:59 INFO - 'opt_config_files': (), 23:57:59 INFO - 'pip_index': False, 23:57:59 INFO - 'sps_profile': False, 23:57:59 INFO - 'sps_profile_interval': 0, 23:57:59 INFO - 'suite': 'dromaeojs', 23:57:59 INFO - 'system_bits': '32', 23:57:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:57:59 INFO - 'title': 'talos-linux64-ix-023', 23:57:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:57:59 INFO - 'use_talos_json': True, 23:57:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:57:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:57:59 INFO - 'work_dir': 'build'} 23:57:59 INFO - [mozharness: 2016-12-19 07:57:59.417872Z] Running clobber step. 23:57:59 INFO - Running pre-action listener: _resource_record_pre_action 23:57:59 INFO - Running main action method: clobber 23:57:59 INFO - rmtree: /builds/slave/test/build 23:57:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:57:59 INFO - Running post-action listener: _resource_record_post_action 23:57:59 INFO - [mozharness: 2016-12-19 07:57:59.874971Z] Finished clobber step (success) 23:57:59 INFO - [mozharness: 2016-12-19 07:57:59.875070Z] Running read-buildbot-config step. 23:57:59 INFO - Running pre-action listener: _resource_record_pre_action 23:57:59 INFO - Running main action method: read_buildbot_config 23:57:59 INFO - Using buildbot properties: 23:57:59 INFO - { 23:57:59 INFO - "project": "", 23:57:59 INFO - "product": "firefox", 23:57:59 INFO - "script_repo_revision": "default", 23:57:59 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 23:57:59 INFO - "repository": "", 23:57:59 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 23:57:59 INFO - "buildid": "20161218230638", 23:57:59 INFO - "pgo_build": "False", 23:57:59 INFO - "basedir": "/builds/slave/test", 23:57:59 INFO - "buildnumber": 32, 23:57:59 INFO - "slavename": "talos-linux64-ix-023", 23:57:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:57:59 INFO - "platform": "ubuntu64_hw", 23:57:59 INFO - "scheduler": "tests-graphics-linux64-talos", 23:57:59 INFO - "branch": "graphics", 23:57:59 INFO - "repo_path": "projects/graphics", 23:57:59 INFO - "revision": "f50d8d3977f82b6161a2561b3b07f3fc45d65cd3", 23:57:59 INFO - "stage_platform": "linux64", 23:57:59 INFO - "builduid": "33e68f8dfb9948aabb913b39e16cb0bc", 23:57:59 INFO - "slavebuilddir": "test" 23:57:59 INFO - } 23:57:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 23:57:59 INFO - Running post-action listener: _resource_record_post_action 23:57:59 INFO - [mozharness: 2016-12-19 07:57:59.877482Z] Finished read-buildbot-config step (success) 23:57:59 INFO - [mozharness: 2016-12-19 07:57:59.877568Z] Running download-and-extract step. 23:57:59 INFO - Running pre-action listener: _resource_record_pre_action 23:57:59 INFO - Running main action method: download_and_extract 23:57:59 INFO - mkdir: /builds/slave/test/build/tests 23:57:59 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')]} 23:57:59 INFO - trying https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 23:57:59 INFO - Downloading https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/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 23:57:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/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 23:58:00 INFO - Downloaded 1361 bytes. 23:58:00 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 23:58:00 INFO - Using the following test package requirements: 23:58:00 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 23:58:00 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:58:00 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:58:00 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:00 INFO - u'jsshell-linux-x86_64.zip'], 23:58:00 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:58:00 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 23:58:00 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:58:00 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:58:00 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:58:00 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 23:58:00 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:58:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:58:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 23:58:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:58:00 INFO - Fetch https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:58:01 INFO - Expected file size: 20213302 23:58:01 INFO - Obtained file size: 20213302 23:58:05 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 23:58:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 23:58:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:58:05 INFO - Fetch https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:58:05 INFO - Expected file size: 20213302 23:58:05 INFO - Obtained file size: 20213302 23:58:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 23:58:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:58:10 INFO - Fetch https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:58:11 INFO - Expected file size: 14409734 23:58:11 INFO - Obtained file size: 14409734 23:58:11 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')]} 23:58:11 INFO - trying https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 23:58:11 INFO - Downloading https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/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 23:58:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/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 23:58:12 INFO - Downloaded 55607249 bytes. 23:58:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 23:58:12 INFO - mkdir: /builds/slave/test/properties 23:58:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:58:12 INFO - Writing to file /builds/slave/test/properties/build_url 23:58:12 INFO - Contents: 23:58:12 INFO - build_url:https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 23:58:13 INFO - Running post-action listener: _resource_record_post_action 23:58:13 INFO - Running post-action listener: set_extra_try_arguments 23:58:13 INFO - [mozharness: 2016-12-19 07:58:13.308756Z] Finished download-and-extract step (success) 23:58:13 INFO - [mozharness: 2016-12-19 07:58:13.308981Z] Running populate-webroot step. 23:58:13 INFO - Running pre-action listener: _resource_record_pre_action 23:58:13 INFO - Running main action method: populate_webroot 23:58:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:58:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:58:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:58:13 INFO - '--tppagecycles', 23:58:13 INFO - '7'], 23:58:13 INFO - 'tests': ['tsvgm']}}, 23:58:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:58:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:58:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:58:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:58:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:58:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:58:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 23:58:13 INFO - 'talos_options': ['--disable-e10s'], 23:58:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:58:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:58:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:58:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 23:58:13 INFO - 'talos_options': ['--disable-e10s'], 23:58:13 INFO - 'tests': ['damp', 'tps']}, 23:58:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:58:13 INFO - 'tests': ['damp', 'tps']}, 23:58:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:58:13 INFO - 'tests': ['dromaeo_dom']}, 23:58:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:58:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:58:13 INFO - 'tests': ['basic_compositor_video']}, 23:58:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:58:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:58:13 INFO - 'tests': ['a11yr', 23:58:13 INFO - 'ts_paint', 23:58:13 INFO - 'tpaint', 23:58:13 INFO - 'sessionrestore', 23:58:13 INFO - 'sessionrestore_no_auto_restore', 23:58:13 INFO - 'tabpaint']}, 23:58:13 INFO - 'other-e10s': {'tests': ['a11yr', 23:58:13 INFO - 'ts_paint', 23:58:13 INFO - 'tpaint', 23:58:13 INFO - 'sessionrestore', 23:58:13 INFO - 'sessionrestore_no_auto_restore', 23:58:13 INFO - 'tabpaint']}, 23:58:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:58:13 INFO - 'ts_paint', 23:58:13 INFO - 'tpaint', 23:58:13 INFO - 'sessionrestore', 23:58:13 INFO - 'sessionrestore_no_auto_restore', 23:58:13 INFO - 'tabpaint']}, 23:58:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:58:13 INFO - 'ts_paint', 23:58:13 INFO - 'tpaint', 23:58:13 INFO - 'sessionrestore', 23:58:13 INFO - 'sessionrestore_no_auto_restore', 23:58:13 INFO - 'tabpaint']}, 23:58:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:58:13 INFO - 'tests': ['a11yr', 23:58:13 INFO - 'ts_paint', 23:58:13 INFO - 'tpaint', 23:58:13 INFO - 'sessionrestore', 23:58:13 INFO - 'sessionrestore_no_auto_restore', 23:58:13 INFO - 'tabpaint']}, 23:58:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:58:13 INFO - 'tests': ['a11yr', 23:58:13 INFO - 'ts_paint', 23:58:13 INFO - 'tpaint', 23:58:13 INFO - 'sessionrestore', 23:58:13 INFO - 'sessionrestore_no_auto_restore', 23:58:13 INFO - 'tabpaint']}, 23:58:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:58:13 INFO - 'tests': ['tsvgx', 23:58:13 INFO - 'tsvgr_opacity', 23:58:13 INFO - 'tart', 23:58:13 INFO - 'tscrollx', 23:58:13 INFO - 'cart', 23:58:13 INFO - 'tsvg_static']}, 23:58:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:58:13 INFO - 'tsvgr_opacity', 23:58:13 INFO - 'tart', 23:58:13 INFO - 'tscrollx', 23:58:13 INFO - 'cart', 23:58:13 INFO - 'tsvg_static']}, 23:58:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 23:58:13 INFO - 'talos_options': ['--disable-e10s'], 23:58:13 INFO - 'tests': ['tp5o']}, 23:58:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:58:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 23:58:13 INFO - 'talos_options': ['--disable-e10s', 23:58:13 INFO - '--xperf_path', 23:58:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:58:13 INFO - 'tests': ['tp5n']}, 23:58:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:58:13 INFO - 'talos_options': ['--xperf_path', 23:58:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:58:13 INFO - 'tests': ['tp5n']}}, 23:58:13 INFO - 'talos.zip': {'path': '', 23:58:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:58:13 INFO - Running post-action listener: _resource_record_post_action 23:58:13 INFO - [mozharness: 2016-12-19 07:58:13.330207Z] Finished populate-webroot step (success) 23:58:13 INFO - [mozharness: 2016-12-19 07:58:13.330296Z] Running create-virtualenv step. 23:58:13 INFO - Running pre-action listener: _resource_record_pre_action 23:58:13 INFO - Running main action method: create_virtualenv 23:58:13 INFO - Creating virtualenv /builds/slave/test/build/venv 23:58:13 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 23:58:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:58:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:58:13 INFO - Using real prefix '/usr' 23:58:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:58:13 INFO - Installing distribute.............................................................................................................................................................................................done. 23:58:15 INFO - Installing pip.................done. 23:58:15 INFO - Return code: 0 23:58:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:58:16 INFO - Reading from file tmpfile_stdout 23:58:16 INFO - Output received: 23:58:16 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) 23:58:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:58:16 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')]} 23:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:16 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')]} 23:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7ff2a9d1ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127f20>, '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 0x1094c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', '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 23:58:16 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 23:58:16 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 23:58:16 INFO - Using env: {'DISPLAY': ':0', 23:58:16 INFO - 'HOME': '/home/cltbld', 23:58:16 INFO - 'LANG': 'en_US.UTF-8', 23:58:16 INFO - 'LANGUAGE': 'en_US:en', 23:58:16 INFO - 'LOGNAME': 'cltbld', 23:58:16 INFO - 'MAIL': '/var/mail/cltbld', 23:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:16 INFO - 'MOZ_NO_REMOTE': '1', 23:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:16 INFO - 'NO_EM_RESTART': '1', 23:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:16 INFO - 'PWD': '/builds/slave/test', 23:58:16 INFO - 'SHELL': '/bin/bash', 23:58:16 INFO - 'SHLVL': '1', 23:58:16 INFO - 'TERM': 'linux', 23:58:16 INFO - 'TMOUT': '86400', 23:58:16 INFO - 'USER': 'cltbld', 23:58:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', 23:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:16 INFO - '_': '/tools/buildbot/bin/python'} 23:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:16 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 23:58:16 INFO - Cleaning up... 23:58:16 INFO - Return code: 0 23:58:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:58:16 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')]} 23:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:16 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')]} 23:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7ff2a9d1ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127f20>, '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 0x1094c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', '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 23:58:16 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 23:58:16 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 23:58:16 INFO - Using env: {'DISPLAY': ':0', 23:58:16 INFO - 'HOME': '/home/cltbld', 23:58:16 INFO - 'LANG': 'en_US.UTF-8', 23:58:16 INFO - 'LANGUAGE': 'en_US:en', 23:58:16 INFO - 'LOGNAME': 'cltbld', 23:58:16 INFO - 'MAIL': '/var/mail/cltbld', 23:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:16 INFO - 'MOZ_NO_REMOTE': '1', 23:58:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:16 INFO - 'NO_EM_RESTART': '1', 23:58:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:16 INFO - 'PWD': '/builds/slave/test', 23:58:16 INFO - 'SHELL': '/bin/bash', 23:58:16 INFO - 'SHLVL': '1', 23:58:16 INFO - 'TERM': 'linux', 23:58:16 INFO - 'TMOUT': '86400', 23:58:16 INFO - 'USER': 'cltbld', 23:58:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', 23:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:16 INFO - '_': '/tools/buildbot/bin/python'} 23:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:16 INFO - Downloading/unpacking psutil>=3.1.1 23:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:16 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 23:58:16 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 23:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:58:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:58:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:58:18 INFO - Installing collected packages: psutil 23:58:18 INFO - Running setup.py install for psutil 23:58:18 INFO - building 'psutil._psutil_linux' extension 23:58:18 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 23:58:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:58:18 INFO - building 'psutil._psutil_posix' extension 23:58:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:58:19 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 23:58:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:58:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:58:19 INFO - Successfully installed psutil 23:58:19 INFO - Cleaning up... 23:58:19 INFO - Return code: 0 23:58:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:58: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')]} 23:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58: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')]} 23:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:19 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 0x7ff2a9d1ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127f20>, '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 0x1094c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', '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 23:58:19 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 23:58:19 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 23:58:19 INFO - Using env: {'DISPLAY': ':0', 23:58:19 INFO - 'HOME': '/home/cltbld', 23:58:19 INFO - 'LANG': 'en_US.UTF-8', 23:58:19 INFO - 'LANGUAGE': 'en_US:en', 23:58:19 INFO - 'LOGNAME': 'cltbld', 23:58:19 INFO - 'MAIL': '/var/mail/cltbld', 23:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:19 INFO - 'MOZ_NO_REMOTE': '1', 23:58:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:19 INFO - 'NO_EM_RESTART': '1', 23:58:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:19 INFO - 'PWD': '/builds/slave/test', 23:58:19 INFO - 'SHELL': '/bin/bash', 23:58:19 INFO - 'SHLVL': '1', 23:58:19 INFO - 'TERM': 'linux', 23:58:19 INFO - 'TMOUT': '86400', 23:58:19 INFO - 'USER': 'cltbld', 23:58:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', 23:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:19 INFO - '_': '/tools/buildbot/bin/python'} 23:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:19 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 23:58:19 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 23:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:58:21 INFO - Installing collected packages: mozsystemmonitor 23:58:21 INFO - Running setup.py install for mozsystemmonitor 23:58:21 INFO - Successfully installed mozsystemmonitor 23:58:21 INFO - Cleaning up... 23:58:21 INFO - Return code: 0 23:58:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:58:21 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')]} 23:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:21 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')]} 23:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:21 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 0x7ff2a9d1ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127f20>, '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 0x1094c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', '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 23:58:21 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 23:58:21 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 23:58:21 INFO - Using env: {'DISPLAY': ':0', 23:58:21 INFO - 'HOME': '/home/cltbld', 23:58:21 INFO - 'LANG': 'en_US.UTF-8', 23:58:21 INFO - 'LANGUAGE': 'en_US:en', 23:58:21 INFO - 'LOGNAME': 'cltbld', 23:58:21 INFO - 'MAIL': '/var/mail/cltbld', 23:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:21 INFO - 'MOZ_NO_REMOTE': '1', 23:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:21 INFO - 'NO_EM_RESTART': '1', 23:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:21 INFO - 'PWD': '/builds/slave/test', 23:58:21 INFO - 'SHELL': '/bin/bash', 23:58:21 INFO - 'SHLVL': '1', 23:58:21 INFO - 'TERM': 'linux', 23:58:21 INFO - 'TMOUT': '86400', 23:58:21 INFO - 'USER': 'cltbld', 23:58:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', 23:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:21 INFO - '_': '/tools/buildbot/bin/python'} 23:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:21 INFO - Downloading/unpacking jsonschema==2.5.1 23:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:21 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 23:58:21 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 23:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:58:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:23 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 23:58:23 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 23:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:24 INFO - Downloading functools32-3.2.3-2.tar.gz 23:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:58:24 INFO - warning: no files found matching '*.txt' 23:58:24 INFO - no previously-included directories found matching 'build' 23:58:24 INFO - no previously-included directories found matching 'dist' 23:58:24 INFO - no previously-included directories found matching '.git*' 23:58:24 INFO - Installing collected packages: jsonschema, functools32 23:58:24 INFO - Running setup.py install for functools32 23:58:24 INFO - warning: no files found matching '*.txt' 23:58:24 INFO - no previously-included directories found matching 'build' 23:58:24 INFO - no previously-included directories found matching 'dist' 23:58:24 INFO - no previously-included directories found matching '.git*' 23:58:24 INFO - Successfully installed jsonschema functools32 23:58:24 INFO - Cleaning up... 23:58:24 INFO - Return code: 0 23:58:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:58:24 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')]} 23:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:24 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')]} 23:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:24 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 0x7ff2a9d1ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127f20>, '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 0x1094c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', '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 23:58:24 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 23:58:24 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 23:58:24 INFO - Using env: {'DISPLAY': ':0', 23:58:24 INFO - 'HOME': '/home/cltbld', 23:58:24 INFO - 'LANG': 'en_US.UTF-8', 23:58:24 INFO - 'LANGUAGE': 'en_US:en', 23:58:24 INFO - 'LOGNAME': 'cltbld', 23:58:24 INFO - 'MAIL': '/var/mail/cltbld', 23:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:24 INFO - 'MOZ_NO_REMOTE': '1', 23:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:24 INFO - 'NO_EM_RESTART': '1', 23:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:24 INFO - 'PWD': '/builds/slave/test', 23:58:24 INFO - 'SHELL': '/bin/bash', 23:58:24 INFO - 'SHLVL': '1', 23:58:24 INFO - 'TERM': 'linux', 23:58:24 INFO - 'TMOUT': '86400', 23:58:24 INFO - 'USER': 'cltbld', 23:58:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', 23:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:24 INFO - '_': '/tools/buildbot/bin/python'} 23:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:58:24 INFO - Cleaning up... 23:58:24 INFO - Return code: 0 23:58:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:58:24 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')]} 23:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:24 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')]} 23:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:24 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 0x7ff2a9d1ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127f20>, '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 0x1094c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', '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 23:58:24 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 23:58:24 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 23:58:24 INFO - Using env: {'DISPLAY': ':0', 23:58:24 INFO - 'HOME': '/home/cltbld', 23:58:24 INFO - 'LANG': 'en_US.UTF-8', 23:58:24 INFO - 'LANGUAGE': 'en_US:en', 23:58:24 INFO - 'LOGNAME': 'cltbld', 23:58:24 INFO - 'MAIL': '/var/mail/cltbld', 23:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:24 INFO - 'MOZ_NO_REMOTE': '1', 23:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:24 INFO - 'NO_EM_RESTART': '1', 23:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:24 INFO - 'PWD': '/builds/slave/test', 23:58:24 INFO - 'SHELL': '/bin/bash', 23:58:24 INFO - 'SHLVL': '1', 23:58:24 INFO - 'TERM': 'linux', 23:58:24 INFO - 'TMOUT': '86400', 23:58:24 INFO - 'USER': 'cltbld', 23:58:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', 23:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:24 INFO - '_': '/tools/buildbot/bin/python'} 23:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:24 INFO - Downloading/unpacking blobuploader==1.2.4 23:58:24 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 23:58:24 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 23:58:24 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 23:58:24 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 23:58:24 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 23:58:24 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 23:58:26 INFO - Downloading blobuploader-1.2.4.tar.gz 23:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:58:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:26 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 23:58:26 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 23:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:58:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:58:27 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 23:58:27 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 23:58:27 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 23:58:27 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 23:58:27 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 23:58:27 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 23:58:27 INFO - Downloading docopt-0.6.1.tar.gz 23:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:58:27 INFO - Installing collected packages: blobuploader, requests, docopt 23:58:27 INFO - Running setup.py install for blobuploader 23:58:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:58:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:58:27 INFO - Running setup.py install for requests 23:58:27 INFO - Running setup.py install for docopt 23:58:28 INFO - Successfully installed blobuploader requests docopt 23:58:28 INFO - Cleaning up... 23:58:28 INFO - Return code: 0 23:58:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:58:28 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')]} 23:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:28 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')]} 23:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:28 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 0x7ff2a9d1ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127f20>, '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 0x1094c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', '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 23:58:28 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 23:58:28 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 23:58:28 INFO - Using env: {'DISPLAY': ':0', 23:58:28 INFO - 'HOME': '/home/cltbld', 23:58:28 INFO - 'LANG': 'en_US.UTF-8', 23:58:28 INFO - 'LANGUAGE': 'en_US:en', 23:58:28 INFO - 'LOGNAME': 'cltbld', 23:58:28 INFO - 'MAIL': '/var/mail/cltbld', 23:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:28 INFO - 'MOZ_NO_REMOTE': '1', 23:58:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:28 INFO - 'NO_EM_RESTART': '1', 23:58:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:28 INFO - 'PWD': '/builds/slave/test', 23:58:28 INFO - 'SHELL': '/bin/bash', 23:58:28 INFO - 'SHLVL': '1', 23:58:28 INFO - 'TERM': 'linux', 23:58:28 INFO - 'TMOUT': '86400', 23:58:28 INFO - 'USER': 'cltbld', 23:58:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', 23:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:28 INFO - '_': '/tools/buildbot/bin/python'} 23:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:58:28 INFO - Running setup.py (path:/tmp/pip-m3RkmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:58:28 INFO - Running setup.py (path:/tmp/pip-eyFr82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:58:28 INFO - Running setup.py (path:/tmp/pip-8ZI325-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:58:28 INFO - Running setup.py (path:/tmp/pip-NsKgbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:58:28 INFO - Running setup.py (path:/tmp/pip-1kXf5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:58:28 INFO - Running setup.py (path:/tmp/pip-wvaNG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:58:28 INFO - Running setup.py (path:/tmp/pip-vbzYRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:58:28 INFO - Running setup.py (path:/tmp/pip-TxW7dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:58:28 INFO - Running setup.py (path:/tmp/pip-UM2VCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:58:29 INFO - Running setup.py (path:/tmp/pip-z2QgHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:58:29 INFO - Running setup.py (path:/tmp/pip-scl3Up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:58:29 INFO - Running setup.py (path:/tmp/pip-AVrMye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:58:29 INFO - Running setup.py (path:/tmp/pip-LE73x0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:58:29 INFO - Running setup.py (path:/tmp/pip-qtzc9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:29 INFO - Running setup.py (path:/tmp/pip-HN0BPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:58:29 INFO - Running setup.py (path:/tmp/pip-gz6mt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:58:29 INFO - Running setup.py (path:/tmp/pip-D2oyaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:58:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:58:29 INFO - Running setup.py install for manifestparser 23:58:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:58:29 INFO - Running setup.py install for mozcrash 23:58:29 INFO - Running setup.py install for mozdebug 23:58:29 INFO - Running setup.py install for mozdevice 23:58:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:58:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:58:30 INFO - Running setup.py install for mozfile 23:58:30 INFO - Running setup.py install for mozhttpd 23:58:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:58:30 INFO - Running setup.py install for mozinfo 23:58:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:58:30 INFO - Running setup.py install for mozInstall 23:58:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:58:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:58:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:58:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:58:30 INFO - Running setup.py install for mozleak 23:58:30 INFO - Running setup.py install for mozlog 23:58:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:58:30 INFO - Running setup.py install for moznetwork 23:58:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:58:30 INFO - Running setup.py install for mozprocess 23:58:30 INFO - Running setup.py install for mozprofile 23:58:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:58:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:58:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:58:30 INFO - Running setup.py install for mozrunner 23:58:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:58:31 INFO - Running setup.py install for mozscreenshot 23:58:31 INFO - Running setup.py install for moztest 23:58:31 INFO - Running setup.py install for mozversion 23:58:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:58:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:58:31 INFO - Cleaning up... 23:58:31 INFO - Return code: 0 23:58:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:58:31 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')]} 23:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:31 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')]} 23:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:31 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 0x7ff2a9d1ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127f20>, '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 0x1094c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', '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 23:58:31 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 23:58:31 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 23:58:31 INFO - Using env: {'DISPLAY': ':0', 23:58:31 INFO - 'HOME': '/home/cltbld', 23:58:31 INFO - 'LANG': 'en_US.UTF-8', 23:58:31 INFO - 'LANGUAGE': 'en_US:en', 23:58:31 INFO - 'LOGNAME': 'cltbld', 23:58:31 INFO - 'MAIL': '/var/mail/cltbld', 23:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:31 INFO - 'MOZ_NO_REMOTE': '1', 23:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:31 INFO - 'NO_EM_RESTART': '1', 23:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:31 INFO - 'PWD': '/builds/slave/test', 23:58:31 INFO - 'SHELL': '/bin/bash', 23:58:31 INFO - 'SHLVL': '1', 23:58:31 INFO - 'TERM': 'linux', 23:58:31 INFO - 'TMOUT': '86400', 23:58:31 INFO - 'USER': 'cltbld', 23:58:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', 23:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:31 INFO - '_': '/tools/buildbot/bin/python'} 23:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:58:31 INFO - Running setup.py (path:/tmp/pip-nHXpaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:58:31 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)) 23:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:58:31 INFO - Running setup.py (path:/tmp/pip-fydd7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:58:31 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)) 23:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:58:31 INFO - Running setup.py (path:/tmp/pip-7gvno1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:58:31 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)) 23:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:58:31 INFO - Running setup.py (path:/tmp/pip-cL1TKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:58:31 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)) 23:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:58:31 INFO - Running setup.py (path:/tmp/pip-zCoVA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:58:31 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)) 23:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:58:31 INFO - Running setup.py (path:/tmp/pip-cMfdU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:58:32 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)) 23:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:58:32 INFO - Running setup.py (path:/tmp/pip-5igi3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:58:32 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)) 23:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:58:32 INFO - Running setup.py (path:/tmp/pip-TYnQS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:58:32 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)) 23:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:58:32 INFO - Running setup.py (path:/tmp/pip-z7kj5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:58:32 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)) 23:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:58:32 INFO - Running setup.py (path:/tmp/pip-L2UfOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:58:32 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)) 23:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:58:32 INFO - Running setup.py (path:/tmp/pip-YQmUD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:58:32 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)) 23:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:58:32 INFO - Running setup.py (path:/tmp/pip-DfBcer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:58:32 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)) 23:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:58:32 INFO - Running setup.py (path:/tmp/pip-fP4EYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:58:32 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)) 23:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:58:32 INFO - Running setup.py (path:/tmp/pip-GBr9k0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:58:32 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)) 23:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:32 INFO - Running setup.py (path:/tmp/pip-9EPaQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:32 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)) 23:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:58:32 INFO - Running setup.py (path:/tmp/pip-azcj6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:58:32 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)) 23:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:58:32 INFO - Running setup.py (path:/tmp/pip-fvMO9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:58:32 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)) 23:58:32 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)) 23:58:32 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)) 23:58:32 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)) 23:58:32 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)) 23:58:32 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)) 23:58:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:58:32 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 23:58:32 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 23:58:32 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 23:58:32 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 23:58:32 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 23:58:32 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 23:58:34 INFO - Downloading blessings-1.6.tar.gz 23:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:58:34 INFO - Installing collected packages: blessings 23:58:34 INFO - Running setup.py install for blessings 23:58:35 INFO - Successfully installed blessings 23:58:35 INFO - Cleaning up... 23:58:35 INFO - Return code: 0 23:58:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:58:35 INFO - Reading from file tmpfile_stdout 23:58:35 INFO - Current package versions: 23:58:35 INFO - argparse == 1.2.1 23:58:35 INFO - blessings == 1.6 23:58:35 INFO - blobuploader == 1.2.4 23:58:35 INFO - docopt == 0.6.1 23:58:35 INFO - functools32 == 3.2.3-2 23:58:35 INFO - jsonschema == 2.5.1 23:58:35 INFO - manifestparser == 1.1 23:58:35 INFO - mozInstall == 1.12 23:58:35 INFO - mozcrash == 1.0 23:58:35 INFO - mozdebug == 0.1 23:58:35 INFO - mozdevice == 0.49 23:58:35 INFO - mozfile == 1.2 23:58:35 INFO - mozhttpd == 0.7 23:58:35 INFO - mozinfo == 0.9 23:58:35 INFO - mozleak == 0.1 23:58:35 INFO - mozlog == 3.4 23:58:35 INFO - moznetwork == 0.27 23:58:35 INFO - mozprocess == 0.23 23:58:35 INFO - mozprofile == 0.28 23:58:35 INFO - mozrunner == 6.13 23:58:35 INFO - mozscreenshot == 0.1 23:58:35 INFO - mozsystemmonitor == 0.3 23:58:35 INFO - moztest == 0.7 23:58:35 INFO - mozversion == 1.4 23:58:35 INFO - psutil == 3.1.1 23:58:35 INFO - requests == 1.2.3 23:58:35 INFO - wsgiref == 0.1.2 23:58:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:58:35 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')]} 23:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:35 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')]} 23:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:35 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 0x7ff2a9d1ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127f20>, '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 0x1094c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', '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 23:58:35 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 23:58:35 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 23:58:35 INFO - Using env: {'DISPLAY': ':0', 23:58:35 INFO - 'HOME': '/home/cltbld', 23:58:35 INFO - 'LANG': 'en_US.UTF-8', 23:58:35 INFO - 'LANGUAGE': 'en_US:en', 23:58:35 INFO - 'LOGNAME': 'cltbld', 23:58:35 INFO - 'MAIL': '/var/mail/cltbld', 23:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:35 INFO - 'MOZ_NO_REMOTE': '1', 23:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:35 INFO - 'NO_EM_RESTART': '1', 23:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:35 INFO - 'PWD': '/builds/slave/test', 23:58:35 INFO - 'SHELL': '/bin/bash', 23:58:35 INFO - 'SHLVL': '1', 23:58:35 INFO - 'TERM': 'linux', 23:58:35 INFO - 'TMOUT': '86400', 23:58:35 INFO - 'USER': 'cltbld', 23:58:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', 23:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:35 INFO - '_': '/tools/buildbot/bin/python'} 23:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:35 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)) 23:58:35 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)) 23:58:35 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)) 23:58:35 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)) 23:58:35 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)) 23:58:35 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)) 23:58:35 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)) 23:58:35 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)) 23:58:35 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)) 23:58:35 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)) 23:58:35 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)) 23:58:35 INFO - Cleaning up... 23:58:35 INFO - Return code: 0 23:58:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:58:35 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')]} 23:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:35 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')]} 23:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:35 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 0x7ff2a9d1ee30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1097120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1127f20>, '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 0x1094c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', '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 23:58:35 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 23:58:35 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 23:58:35 INFO - Using env: {'DISPLAY': ':0', 23:58:35 INFO - 'HOME': '/home/cltbld', 23:58:35 INFO - 'LANG': 'en_US.UTF-8', 23:58:35 INFO - 'LANGUAGE': 'en_US:en', 23:58:35 INFO - 'LOGNAME': 'cltbld', 23:58:35 INFO - 'MAIL': '/var/mail/cltbld', 23:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:35 INFO - 'MOZ_NO_REMOTE': '1', 23:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:35 INFO - 'NO_EM_RESTART': '1', 23:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:35 INFO - 'PWD': '/builds/slave/test', 23:58:35 INFO - 'SHELL': '/bin/bash', 23:58:35 INFO - 'SHLVL': '1', 23:58:35 INFO - 'TERM': 'linux', 23:58:35 INFO - 'TMOUT': '86400', 23:58:35 INFO - 'USER': 'cltbld', 23:58:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', 23:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:35 INFO - '_': '/tools/buildbot/bin/python'} 23:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:58:35 INFO - Cleaning up... 23:58:35 INFO - Return code: 0 23:58:35 INFO - Running post-action listener: _resource_record_post_action 23:58:35 INFO - Running post-action listener: _start_resource_monitoring 23:58:35 INFO - Starting resource monitoring. 23:58:35 INFO - [mozharness: 2016-12-19 07:58:35.803194Z] Finished create-virtualenv step (success) 23:58:35 INFO - [mozharness: 2016-12-19 07:58:35.803675Z] Running install step. 23:58:35 INFO - Running pre-action listener: _resource_record_pre_action 23:58:35 INFO - Running main action method: install 23:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:58:36 INFO - Reading from file tmpfile_stdout 23:58:36 INFO - Detecting whether we're running mozinstall >=1.0... 23:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:58:36 INFO - Reading from file tmpfile_stdout 23:58:36 INFO - Output received: 23:58:36 INFO - Usage: mozinstall [options] installer 23:58:36 INFO - Options: 23:58:36 INFO - -h, --help show this help message and exit 23:58:36 INFO - -d DEST, --destination=DEST 23:58:36 INFO - Directory to install application into. [default: 23:58:36 INFO - "/builds/slave/test"] 23:58:36 INFO - --app=APP Application being installed. [default: firefox] 23:58:36 INFO - mkdir: /builds/slave/test/build/application 23:58:36 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'] 23:58:36 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 23:58:52 INFO - Reading from file tmpfile_stdout 23:58:52 INFO - Output received: 23:58:52 INFO - /builds/slave/test/build/application/firefox/firefox 23:58:52 INFO - Running post-action listener: _resource_record_post_action 23:58:52 INFO - [mozharness: 2016-12-19 07:58:52.145845Z] Finished install step (success) 23:58:52 INFO - [mozharness: 2016-12-19 07:58:52.146143Z] Running run-tests step. 23:58:52 INFO - Running pre-action listener: _resource_record_pre_action 23:58:52 INFO - Running main action method: run_tests 23:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:58:52 INFO - Python 2.7.3 23:58:52 INFO - Return code: 0 23:58:52 INFO - grabbing minidump binary from tooltool 23:58:52 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')]} 23:58:52 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 0x1127f20>, '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 0x1094c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1094f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:58:52 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 23:58:52 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 23:58:52 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 23:58:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:58:52 INFO - Return code: 0 23:58:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:58:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:58:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:58:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:58:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:58:52 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/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 23:58:52 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/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 23:58:52 INFO - Using env: {'DISPLAY': ':0', 23:58:52 INFO - 'HOME': '/home/cltbld', 23:58:52 INFO - 'LANG': 'en_US.UTF-8', 23:58:52 INFO - 'LANGUAGE': 'en_US:en', 23:58:52 INFO - 'LOGNAME': 'cltbld', 23:58:52 INFO - 'MAIL': '/var/mail/cltbld', 23:58:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:58:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:52 INFO - 'MOZ_NO_REMOTE': '1', 23:58:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:58:52 INFO - 'NO_EM_RESTART': '1', 23:58:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:52 INFO - 'PWD': '/builds/slave/test', 23:58:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:58:52 INFO - 'SHELL': '/bin/bash', 23:58:52 INFO - 'SHLVL': '1', 23:58:52 INFO - 'TERM': 'linux', 23:58:52 INFO - 'TMOUT': '86400', 23:58:52 INFO - 'USER': 'cltbld', 23:58:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455', 23:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:52 INFO - '_': '/tools/buildbot/bin/python'} 23:58:52 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/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 23:58:52 INFO - mozversion application_buildid: 20161218230638 23:58:52 INFO - mozversion application_changeset: f50d8d3977f82b6161a2561b3b07f3fc45d65cd3 23:58:52 INFO - mozversion application_display_name: Nightly 23:58:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:58:52 INFO - mozversion application_name: Firefox 23:58:52 INFO - mozversion application_remotingname: firefox 23:58:52 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 23:58:52 INFO - mozversion application_vendor: Mozilla 23:58:52 INFO - mozversion application_version: 53.0a1 23:58:52 INFO - mozversion platform_buildid: 20161218230638 23:58:52 INFO - mozversion platform_changeset: f50d8d3977f82b6161a2561b3b07f3fc45d65cd3 23:58:52 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 23:58:52 INFO - mozversion platform_version: 53.0a1 23:58:52 INFO - using testdate: 1482134332 23:58:52 INFO - actual date: 1482134332 23:58:52 INFO - starting webserver on 'localhost:43301' 23:58:52 INFO - SUITE-START | Running 2 tests 23:58:52 INFO - TEST-START | dromaeo_css 23:58:52 INFO - operating with platform_type : linux_ 23:58:52 INFO - Initialising browser for dromaeo_css test... 23:58:52 INFO - TEST-INFO | started process 12685 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpssuEBQ/profile http://localhost:43301/getInfo.html) 23:58:56 INFO - PROCESS | 12685 | __metrics Screen width/height:1600/1200 23:58:56 INFO - PROCESS | 12685 | colorDepth:24 23:58:56 INFO - PROCESS | 12685 | Browser inner width/height: 1024/697 23:58:56 INFO - PROCESS | 12685 | __metrics 23:58:56 INFO - PROCESS | 12685 | 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" 23:58:56 INFO - PROCESS | 12685 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:58:57 INFO - PROCESS | 12685 | console.error: PushService: 23:58:57 INFO - PROCESS | 12685 | stateChangeProcessEnqueue: Error transitioning state 23:58:57 INFO - PROCESS | 12685 | UnknownError 23:58:58 INFO - TEST-INFO | 12685: exit 0 23:58:58 INFO - Browser initialized. 23:58:58 INFO - Running cycle 1/1 for dromaeo_css test... 23:58:58 INFO - TEST-INFO | started process 12769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpssuEBQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:59:10 INFO - PROCESS | 12769 | RSS: Main: 155369472 23:59:10 INFO - PROCESS | 12769 | 00:00:01 INFO - PROCESS | 12769 | 1482134401015 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] 00:02:14 INFO - PROCESS | 12769 | Cycle 1(1): loaded http://localhost:43301/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43301/tests/dromaeo/cssquery-ext.html) 00:02:16 INFO - PROCESS | 12769 | RSS: Main: 290041856 00:02:16 INFO - PROCESS | 12769 | 00:05:19 INFO - PROCESS | 12769 | Cycle 1(1): loaded http://localhost:43301/tests/dromaeo/cssquery-ext.html (next: http://localhost:43301/tests/dromaeo/cssquery-jquery.html) 00:05:19 INFO - PROCESS | 12769 | RSS: Main: 238215168 00:05:19 INFO - PROCESS | 12769 | 00:08:22 INFO - PROCESS | 12769 | Cycle 1(1): loaded http://localhost:43301/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43301/tests/dromaeo/cssquery-mootools.html) 00:08:22 INFO - PROCESS | 12769 | RSS: Main: 193662976 00:08:22 INFO - PROCESS | 12769 | 00:11:25 INFO - PROCESS | 12769 | Cycle 1(1): loaded http://localhost:43301/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43301/tests/dromaeo/cssquery-prototype.html) 00:11:25 INFO - PROCESS | 12769 | RSS: Main: 188547072 00:11:25 INFO - PROCESS | 12769 | 00:14:29 INFO - PROCESS | 12769 | Cycle 1(1): loaded http://localhost:43301/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43301/tests/dromaeo/cssquery-yui.html) 00:14:29 INFO - PROCESS | 12769 | RSS: Main: 188215296 00:14:29 INFO - PROCESS | 12769 | 00:17:32 INFO - PROCESS | 12769 | Cycle 1(1): loaded http://localhost:43301/tests/dromaeo/cssquery-yui.html (next: http://localhost:43301/tests/dromaeo/cssquery-dojo.html) 00:17:32 INFO - PROCESS | 12769 | RSS: Main: 275795968 00:17:32 INFO - PROCESS | 12769 | 00:17:32 INFO - PROCESS | 12769 | __start_tp_report 00:17:32 INFO - PROCESS | 12769 | _x_x_mozilla_page_load 00:17:32 INFO - PROCESS | 12769 | _x_x_mozilla_page_load_details 00:17:32 INFO - PROCESS | 12769 | |i|pagename|runs| 00:17:32 INFO - PROCESS | 12769 | |0;dojo.html;2589.0938171639928;2605.491929073829;2621.3839747659304;2637.947241055179;2647.2984659065337;4607.447106347243;4650.162970665279;4719.740414277213;4743.501932297107;4754.286856971452;4695.272232803921;4702.1065997460455;4744.739039352834;4807.639427042968;4808.182608956477;4292.313229883203;4325.372820940962;4338.284183109783;4346.261135606938;4414.889627759299;3939.8424063037446;4405.713628614146;4439.311906654474;4483.506814250446;4520.97739511302;4292.098659281554;4334.631556317717;4416.315471101984;4449.71076880005;4485.237509623355;4353.216421044211;4385.758783266919;4396.560343965578;4399.604035636776;4462;4365.3451982202605;4375.278079116942;4375.474943006828;4384.0355121873135;4420.270655341865;4761.761911904391;4772.809087636525;4779.498152693986;4787.234042553175;4831.879203019917;4932.926006109911;4971.950280497221;4974.651774375795;5033.521815427529;5068.746562671851;5114;5117.130087885069;5119.206522988906;5147.124988751922;5154.072266991978;4770.189067858438;4772.689775164603;4773.451053128934;4776.546228108324;4818.903621927612;5119.10415677255;5184.818531351385;5187.507186817246;5202.193659982709;5265.473452654704;4986.376702912136;5003.624728145331;5008.223725322508;5027.170516864677;5071.036503064406;5102.8214012510125;5103.979204159183;5106.591472682177;5108.361454818148;5154.484551544815;4971.328870602495;5033.471485494044;5066.670666406671;5075.1625981712605;5080.77136528857;5001.799928002912;5062.063518249136;5062.139436295838;5067.214581739836;5070.340855688737;4237.364395340724;4264.616184543406;4284.357346398003;4290.420793192941;4296.677749168824;3737.1965027518672;3742.3076730804887;3768.566614839274;3771.9622803771613;3785.9432108518395;4370.54109318517;4372.060007098489;4372.978135109304;4381.846635367747;4420.204363214588;4964.1809101498575;4966.925496117561;5022.020705962303;5125.1287281162295;5169.4572069932865;4330.415393921843;4332.610065094157;4348.195583817004;4351.26028575143;4407.537208593116;4549.27211646135;4554.886127846764;4555.498895121534;4557.430321209848;4601.631869450436;4646;4773.451053128934;4779.928301075417;4779.976100119547;4818.759062046954;5003.299538064746;5067.87330316745;5081.974590127025;5090.541851233407;5097.158968770112;4792.832250871203;4797.088553174885;4798.49615790337;4822.42130944289;4846.927296090632;5028.220625803006;5028.74856257193;5030.698158110525;5039.470855560114;5041.571466425395;4948.8762780930765;5004.124278251219;5005.34930459038;5031.446540880427;5109.718965456936;4921.50784921505;4973.079980203674;4973.52751488608;4990.201567749143;5008.223725322581;4967.428745694291;4970.950290497193;4975.776090076028;4978.303037574815;4978.8257410990445;4752.881177970578;4793.089313030513;4803.375561177025;4840.7337596431125;4874.488178741181;4916.729579873141;4969.602431805519;4978.726170060681;4979.3526841510375;5033.496650334937;4781.330613714013;4821.445533763522;4859.635527335393;4869.0261947609915;4917.483664215206 00:17:32 INFO - PROCESS | 12769 | |1;ext.html;516.4577193946357;536.9543588794952;547.2830591924579;550.3038656100032;551.2585572405115;29410.117696469115;37004;38418.615813841854;38581.228375432474;42053.7897310513;38992.22015559687;39296.21407571847;39366.40950385747;39377.40933885994;39466.408003879966;7202.17175024871;7538.88691669624;7749.457537972344;7770.766876993699;7772.300492955633;7158.46311526635;9491.098345657152;9792.559334829913;9797.804043919117;10125.59497620098;10005.249606279522;10075.244356673242;10076.94961525195;10078.949605251963;10082.04220599042;10014.799704005916;10081.243906706954;10083.042110999444;10084.092431681183;10095.29332946694;9870.753231169207;9950.651727189586;9950.9502452488;9954.900450995543;9959.103680668703;35938;36200.818995905116;36214.275714485826;36225.81887090574;36270.8186459066;2850.2161905475955;2879.5536691812804;2898.2899189698446;3023.4104349651825;3315.2043509557775;27628.723712762818;27899;28163.85918070417;28254.71745282562;29015.709842901513;3327.73378129749;3338.115399419156;3372.1738174147245;3414.7268218542704;3444.9483257751153;234381;235227.99999999828;236619;236815;237461;50972.745136274825;51273.23090153651;51666.741666291426;51685.48314516882;51702.741486292325;53797.041162735644;53866;53873.73063134659;53922;53942.46057539453;14123.78814317786;14703.926480367743;14745.1890146043;14844.62888427798;14850.183239921907;10078.949605251926;10391.48042597867;10612.787744245072;11334.43327833605;11401.714957125972;15112.622184445478;15350.616234594001;15464.458743943907;15694.215289235493;15926.124063176405;5601.859953501195;5813.94186058134;5828.59199856006;5871.882562348729;5880.26496687914;834.7120243515977;836.9037560680478;856.9571521423904;877.1141147441003;917.8623206519076;25655.230343089737;27712.307192320353;27879;27906.16281511558;27959.58060629092;851.7913111287775;857.9056303806576;873.2446433834688;874.8643960186181;1000.6647772996128;14211.857881421054;14575.562733118024;14637.560873173821;14719.55841324762;14957.626059348604;326442;327138;329818;330728;331155;48135;48301.75849120732;48340.516594834306;48392.51607483951;48393.27410088851;1047.4657924458581;1088.1838621034383;1103.690966529373;1174.0607513988775;1175.0129890891692;25809.225723228334;28128.71871281261;28143.57784633191;30396.696033039385;31097.8445107773;45701;46377.53622463732;46424.767876160404;46493.53506464892;46513.30230046484;301685;305873;306151;306315;307040;22218.222362217246;23104.653430198898;24171.395715107265;24325.391865202804;35256.47115293324;36115.81942090273;36146.819265903505;36303.636963631085;36433.81783091067;36662.8166859164;30638.234044149074;30722.231944201572;30888.53667194949;31073.223169420944;31669.841650791597;30030.549541756453;30243.546346804374;30788.53817192789;31412;31648.683513164575;28850.134495965154;28859.711402885703;29028.983985560404;31241.37517249688;32143.19642008875;27429.86285068562;28584;29181.41637167202;29355.11934641964;29511.202339611875;22444.32667019992;22631.321060368216;22772.4306892329;22809.657855131853;22957.540849183257 00:17:32 INFO - PROCESS | 12769 | |2;jquery.html;372.19791349641497;376.3338890164409;377.9811009449527;378.2774899941112;393.1527558112267;15210.326864044946;15242.618934526643;16597.25312360945;16669.24988375523;16671.1664416779;15577.376904923818;15884.444044458418;16303;16410.589735256624;16421.343146274136;4813.302071199674;5021.924671129936;5042.571381432583;5051.292819005343;5052.115879721053;4969.627277954168;5054.21659642756;5057.5701065409485;5064.392272927235;5064.468230835746;4735.715857048588;4839.419269687643;4851.951480485203;4856.538628830255;4891.1195984722735;4928.137575924216;4932.556069953685;4940.25896115582;4942.061008408409;4943;4270.850520231777;4449.7997590108525;4482;4485.1254005468945;4486.955130448719;19385.9030704847;19805.60388792216;19959.101840417217;20010.29963951255;20171.193152274038;1849.9907500462411;1937.2541571494935;2016.264063616784;2095.9371218863457;2169.197396963118;8630.568471576458;9161.083891610851;12761.106722529426;12877;13358.131721438076;1683.46970704229;1689.2567270400984;1741.547197728587;1770.9645807083914;1779.5373202967191;67903.66048169727;69844.30155698428;69898.30101698969;71554;71689;9606.567704453317;9813.80372392548;9837.409755414697;9977.301588888708;10060.523067235157;13776.724465510633;13787.103838250481;13792.517261895986;13806;13808.309584520734;6536.150300460909;6705.1110355993405;6775.254721980578;6877.277885822016;6891.586504809728;6219.129321894939;6234.719437625317;6375.6174629522375;6379.74481020754;6406.039094135824;4238.19474299882;4253.8723838284905;4289.635380992589;4432.29083346663;4456.955430445719;1706.7013272677232;1734.1329335332334;1808.9276428942694;1830.1306879232259;1832.743415921772;778.8792737125755;816.1512027491342;882.7042940614838;886.8980067292215;948.8244674735196;15623.60940976462;16372.50882473504;17164;17426.825731742774;17496.562585935455;825.5995842016617;834.7746108550779;860.3289434241302;867.7960679240374;873.9475631462133;7723.7682869514;9328.347015708836;9528.285378596633;9762.707118786448;9903.950480247697;333213;336787;339216;339413;339522;71700.64149679219;72516;72960;73188.63405682938;75927.62036189894;879.1691851200682;882.0826340605827;883.0683628771708;886.3396769406833;894.1594900793234;14681.632959176106;14852.62868428298;14918.701625967637;14964.625884352978;15534.84465155334;34148.31703365869;35586.288274233855;35591.686540374794;36497.27005459929;38139;48329.27506087341;49198.50801492082;49416.25875611797;49921.251181233034;50273.74863125661;7469.88795168062;7544.660490277841;7582.962085189539;7619.69521219145;7963.203679631991;8555.700550480704;11364;11493.195476316912;11546.884531154581;11918.52325906954;9671.758206044906;10225.233107517115;10283.177345812168;10377;10665.680029599125;10059.446730429896;10103.343282686601;10349.068583827491;10470.790584188426;10763.51564179598;10268.537915793659;10278.743031423975;10465.895341046797;10676.946615266874;10813.567457301935;7470.813229669085;7476.214997425192;7480.289372509603;7565.886511702219;7594.5063570867715;8788.252998494943;10234.385936843813;10304.793904121725;10405.375677459377;10581.523831427758 00:17:32 INFO - PROCESS | 12769 | |3;mootools.html;1224.755048990201;1305.9608211753648;1341.1626072280974;1420.5738278516449;1677.4548271811664;6085.604435711675;6874.55315404499;7076.964615176923;7134.357907788311;7297.124345078585;7256.092988376453;7335.669894854731;7336.486445948785;7343.4492413068965;7348.926510734891;1852.0924746874002;1910.503269150017;2107.725995620571;2143.732033495813;2152.461884528868;2063.793620637939;2137.7969092936146;2139.155033761663;2144.774798646143;2147.377260594426;2057.506198512361;2060.4127823570284;2062.618415593113;2066.7829877862832;2066.8243199328076;2076.2110398048794;2092.424583239606;2113.471632091977;2125.6067627488965;2125.90433430496;2063.793620637939;2072.523319636477;2086.405374468284;2093.926712565068;2094.099537199004;7122.002919591261;7212.134543854771;7337.816554586125;7339.339459448622;7342.375898048672;4270.167317373113;4410.62509686677;4413.889652758675;4415.072834704716;4415.094905544356;2785.5960885671466;2934.9119526414243;2946.882124715009;2955.069153216751;3022.3955208958077;872.1409411729442;904.4980036079972;921.7050543825978;965.5944503308627;970.1462712812751;9480.099390557885;9491.098345657152;9502.524873756354;9587.520623968774;9707.466089365082;3896.08442016126;4076.0828813516723;4131.29767939451;4157.230912281178;4206.495220573551;7950.324222441157;7960.4825686330205;7962.084360298524;7973.60131993398;7974.003249593801;4439.955600444019;4440.644748420119;4520.118576877478;4525.366448697185;4530.456345238526;3658.231771328051;3866.8259928303296;4044.6157615027114;4046.47395838545;4047.170330082326;3338.966610333914;3394.575678040245;3476.43560397822;3499.825008749603;3519.296140771805;1146.3465824480134;1180.8523934508187;1180.887815657511;1183.952641894332;1183.9822402663967;828.2918105020121;831.1921570584076;831.2061980808313;870.856308709056;871.904090550039;4710.175719249118;4950.381202349707;5008.749562521933;5087.694738315713;5109.591232701375;771.6566128073066;822.2394285286206;829.5478963964654;833.5123952487742;843.7343984023964;3274.8526316315824;3295.7692961492467;3336.366090442808;3347.330533893231;3377.865906555955;8271.710490132817;8565.400421970528;8635.438696484709;8639.740807775777;8664.696735614223;8579.742607721779;8581.184787445183;8583.270422014073;8588.484690918565;8590.398672093019;6335.714892829834;6621.112982799879;6639.402453779183;6802.353776391334;6816.625085620339;4741.952580474152;4743.146233677971;4812.109759694467;4883.461709561477;5223.3209682741;7852.097008844056;7944;8018.759437216893;8050.154733752872;8076.676932922617;7791.4935529190425;7924.445288829726;7960.084590271961;8017.318527925192;8066.83866322682;5547.11246200606;5734.139879018181;5993.340732519332;6105.603135796159;6142.600730952474;6637.103990961158;6948.895766563607;6953.20038195614;7164.570125792469;7165.176004759519;6203.906941395792;6430.678466076771;6434.163558737334;6583.934160658524;6633.336666333328;6190;6199.969000154971;6217.129601855653;6228.750849966132;6239.937600624117;5974.2830860297045;6091.42131497507;6098.237720284965;6100.755969761338;6104.298005729221;4388.144311859284;4534.727916325031;4561.977190114028;4578.885527861697;4606.470255920612;4425.3140763181755;4470.664700147437;4580.290055041474;4596.448426188878;4687.99208170245 00:17:32 INFO - PROCESS | 12769 | |4;prototype.html;352.88002079293034;355.62303957804727;357.7156160852122;359.5308122899616;361.0540384193415;4782.52174782522;4809.374781278438;4816.855494335171;4820.180569303218;4823.94982132594;4766.1182681204;4773.785179666915;4782.736949467778;4792.83225087122;4805.447373552042;3717;3791.810409479515;3793.4499497572833;3812.4662547243406;3848.1149335652817;3853.9148502587345;3858.8070596470207;3877.108265099029;3878.2437424702193;3892.377219644857;3845.3078445879732;3858.5562660294004;3861.884143475686;3862.4978752762104;3873.888730641807;3660.7071434285326;3696.77819330841;3775.528058992626;3872.244912242114;3873.2640798248244;3471.3337597952873;3480.460528618068;3497.6852083312624;3501.9513584553065;3507.894763157084;4664.463586687541;4675.509071547506;4679;4679.391679081732;4693.530646935314;4299.312110062407;4415.359772832953;4418.536053714346;4424.336349547593;4426.627745398937;4962.230854217602;4984.975075124601;5014.774335154927;5016.322796422509;5028.245763135559;3786.8106594670157;3799.411091280856;3800.9619903801163;3812.980935095307;3813.9809300953593;5110.259012443249;5242.318498595158;5258.212207849349;5265.420803711627;5278.419373868871;3880.8059597020037;3907.785071821077;3908.843646254175;3913.1977944521304;3913.5890731473355;3961.7622942623534;3970.225805967866;3980.5024371953505;3981.029390451745;3982.4424580558743;4342.457192850894;4349.217140914602;4367.082912588328;4379.474463064453;4380.802863871069;4891.926621100686;4949.82675606352;4992.400911890524;5007.4491805901325;5036.546710796046;1333.6265845563257;1342.2416334770824;1344.7848344264871;1345.401296423102;1346.5556366399064;924.8751418558543;960.706984369774;965.4070783207624;971.2861047130353;973.1533565797802;4199.181159673895;4311.633511151587;4314.893276840669;4327.17783621111;4339.414179085846;5007.84819491519;5024;5032.194848824171;5148.562372198405;5149.433562308143;4412.955061007894;4420.889477763018;4429.7785110744335;4434.756088415168;4444.155610434007;2582.806289528293;2653.349929267303;2667.519846427662;2672.3319170207446;2688.7094194786614;4669.60308373792;4706.811727530929;4722.929156062662;4729.527047295312;4739.3933336664695;5124.5131712487255;5131.230315452712;5144.202648589399;5151.459096794858;5153.922691159635;4504.234280172379;4701.435827700698;4776.808927642995;4785.588251465826;4804.231322988305;5032.798688052583;5056.797728090835;5095.77069031887;5099.898002040012;5102.938237057736;4939.97530012362;4961.4371472985895;4962.33008543842;4972.8508144755715;4973.850784476472;4600.792964316681;4802.727277271596;4902.975485122552;4904.117258893433;4911.435184953633;3624.4563315502887;3657.23198128396;3684.5394325709285;3685.852565897334;3694.4458331250526;5201.401838788436;5202.3497062867145;5213.270142180022;5217.843464696065;5218.739063046908;4963.5780958618925;5044.468871789835;5073;5076.137056700296;5084;5055.6713813602;5071.898562028812;5074.310615373858;5076.695398276115;5079.292116754716;4970.676906001098;4977.576905963034;4983.725895075806;4984.127777638826;5000.524950129732;4819.7108173509705;4875.658703890836;4926.679765815211;5037.294778730908;5080.974595127149;4801.351817504732;4941.77762000718;4956.744681170131;4965.975170124127;4977.352944117241 00:17:32 INFO - PROCESS | 12769 | |5;yui.html;620.4151321732397;688.1329524798749;727.7671145233527;734.0310789757519;747.0363231431454;12618.621441356763;13537.796933045987;13558.254296013716;13562.389692463837;13586.728265434685;13223;13389;13414.12808167471;13426.798598021012;14378.06542574732;613.4233820208989;639.143547646154;749.7975546602414;767.3017554025838;784.4234487651571;786.8977032985704;787.5392895156341;788.2944764435855;789.2107892107892;790.1229635105029;820.8932838730957;821.5440430561036;821.704186492862;821.7740121466614;821.9095899451086;644.5488158289216;668;780.6331024418514;809.9190080991913;816.6080281464871;607.2621764556086;607.5230943709167;607.6475644126396;607.7204485936475;607.9756809727605;13213.273269970148;13416.262105584188;13418.060735748502;13442.12626179305;13450.798238026437;12245.387730613524;12501.74996500074;12635.43140558677;12724.554640587536;12859.807102893465;11925;11926.522939082426;11943.448825169238;12184.57353992606;12247.69380765488;4040.7575545467366;4069.2065047315787;4113.876583702494;4138.482689663792;4150.91698166038;64374;64400;64820.67589662022;64918;66790;10519.737006574744;10523.94738026305;10937.56249750001;10950.616728414467;11161;18788;19324.32364867223;20266.493337666678;20269.797302027087;20307.79692203059;7006.229314775371;7142.21435642079;7306.7077316906725;7357.632118394166;7437.219091995263;3625.800580968072;3678.08047988003;3685.7788532688123;3721.832517536717;3725.068732816796;3093.133922501703;3154.1799132225788;3171.920701982469;3174.365126974614;3178.698023687746;534.6631622078066;536.3269097282963;548.7804878048812;549.8020712543481;552.6960171905436;513.7225898015105;637.5772066148709;638.4605008767584;649.3993056422885;666.6500087454125;8482.915170848337;8486.533240671699;8557.358198135165;8606.397552171413;8743.114772125184;536.9931378665003;545.6098889294174;597.4563147535808;597.7160848596968;621.3351713666334;3929.214157168578;4165.10450253191;4270.871873843727;4291.2275790358035;4308.698391112592;52555.47444525582;53091;54072;60845;69284.30715692778;44692;47655.76172119117;51268.743656282226;52259;52991;47812.04375912462;48317.516824832004;49465.75267123641;50323;51095.489045109076;8732.257758090633;9198.402103863495;9335.486548239913;9430.796884361947;9480.85778713306;31200.21999450032;31893.521597175597;32326.35347293088;33461.330773384885;34726.47910281398;43224.783876080415;43556;44804.32793508035;45641.31538026999;47954;10620;11287.266327688674;11618.302901825917;11654.18420710576;11816.645500634995;12719.87280127187;12895.935520322339;13238.735225295248;14086.859131408555;14210.218437985597;11435.771284574428;12112.75774484523;12448.937755311166;12615.30615816139;12886.226826390446;11577.768444631229;12012.159148859846;12447.883859744046;12581.93709031449;12949.676258093623;11344.546218151512;11814.527418903148;12009.36235196678;12021.699457513632;12024;9802.36284641496;10085.495725213563;10324.22568307365;10503.684889453329;10544.89455105439;8931.955340223258;9272.582733777132;9614.423134611945;9915.851262230928;10304.793904122025 00:17:32 INFO - PROCESS | 12769 | __end_tp_report 00:17:32 INFO - PROCESS | 12769 | __start_cc_report 00:17:32 INFO - PROCESS | 12769 | _x_x_mozilla_cycle_collect,1607 00:17:32 INFO - PROCESS | 12769 | __end_cc_report 00:17:32 INFO - PROCESS | 12769 | __startTimestamp1482135452896__endTimestamp 00:17:32 INFO - PROCESS | 12769 | 00:17:32 INFO - PROCESS | 12769 | ------- Summary: start ------- 00:17:32 INFO - PROCESS | 12769 | Number of tests: 6 00:17:32 INFO - PROCESS | 12769 | 00:17:32 INFO - PROCESS | 12769 | [#0] dojo.html Cycles:165 Average:4688.88 Median:4807.64 stddev:495.09 (10.3%) stddev-sans-first:468.40 00:17:32 INFO - PROCESS | 12769 | Values: 2589.1 2605.5 2621.4 2637.9 2647.3 4607.4 4650.2 4719.7 4743.5 4754.3 4695.3 4702.1 4744.7 4807.6 4808.2 4292.3 4325.4 4338.3 4346.3 4414.9 3939.8 4405.7 4439.3 4483.5 4521.0 4292.1 4334.6 4416.3 4449.7 4485.2 4353.2 4385.8 4396.6 4399.6 4462.0 4365.3 4375.3 4375.5 4384.0 4420.3 4761.8 4772.8 4779.5 4787.2 4831.9 4932.9 4972.0 4974.7 5033.5 5068.7 5114.0 5117.1 5119.2 5147.1 5154.1 4770.2 4772.7 4773.5 4776.5 4818.9 5119.1 5184.8 5187.5 5202.2 5265.5 4986.4 5003.6 5008.2 5027.2 5071.0 5102.8 5104.0 5106.6 5108.4 5154.5 4971.3 5033.5 5066.7 5075.2 5080.8 5001.8 5062.1 5062.1 5067.2 5070.3 4237.4 4264.6 4284.4 4290.4 4296.7 3737.2 3742.3 3768.6 3772.0 3785.9 4370.5 4372.1 4373.0 4381.8 4420.2 4964.2 4966.9 5022.0 5125.1 5169.5 4330.4 4332.6 4348.2 4351.3 4407.5 4549.3 4554.9 4555.5 4557.4 4601.6 4646.0 4773.5 4779.9 4780.0 4818.8 5003.3 5067.9 5082.0 5090.5 5097.2 4792.8 4797.1 4798.5 4822.4 4846.9 5028.2 5028.7 5030.7 5039.5 5041.6 4948.9 5004.1 5005.3 5031.4 5109.7 4921.5 4973.1 4973.5 4990.2 5008.2 4967.4 4971.0 4975.8 4978.3 4978.8 4752.9 4793.1 4803.4 4840.7 4874.5 4916.7 4969.6 4978.7 4979.4 5033.5 4781.3 4821.4 4859.6 4869.0 4917.5 00:17:32 INFO - PROCESS | 12769 | 00:17:32 INFO - PROCESS | 12769 | [#1] ext.html Cycles:180 Average:44195.44 Median:31169.61 stddev:76790.12 (246.4%) stddev-sans-first:76935.50 00:17:32 INFO - PROCESS | 12769 | Values: 516.5 537.0 547.3 550.3 551.3 29410.1 37004.0 38418.6 38581.2 42053.8 38992.2 39296.2 39366.4 39377.4 39466.4 7202.2 7538.9 7749.5 7770.8 7772.3 7158.5 9491.1 9792.6 9797.8 10125.6 10005.2 10075.2 10076.9 10078.9 10082.0 10014.8 10081.2 10083.0 10084.1 10095.3 9870.8 9950.7 9951.0 9954.9 9959.1 35938.0 36200.8 36214.3 36225.8 36270.8 2850.2 2879.6 2898.3 3023.4 3315.2 27628.7 27899.0 28163.9 28254.7 29015.7 3327.7 3338.1 3372.2 3414.7 3444.9 234381.0 235228.0 236619.0 236815.0 237461.0 50972.7 51273.2 51666.7 51685.5 51702.7 53797.0 53866.0 53873.7 53922.0 53942.5 14123.8 14703.9 14745.2 14844.6 14850.2 10078.9 10391.5 10612.8 11334.4 11401.7 15112.6 15350.6 15464.5 15694.2 15926.1 5601.9 5813.9 5828.6 5871.9 5880.3 834.7 836.9 857.0 877.1 917.9 25655.2 27712.3 27879.0 27906.2 27959.6 851.8 857.9 873.2 874.9 1000.7 14211.9 14575.6 14637.6 14719.6 14957.6 326442.0 327138.0 329818.0 330728.0 331155.0 48135.0 48301.8 48340.5 48392.5 48393.3 1047.5 1088.2 1103.7 1174.1 1175.0 25809.2 28128.7 28143.6 30396.7 31097.8 45701.0 46377.5 46424.8 46493.5 46513.3 301685.0 305873.0 306151.0 306315.0 307040.0 22218.2 23104.7 24171.4 24325.4 35256.5 36115.8 36146.8 36303.6 36433.8 36662.8 30638.2 30722.2 30888.5 31073.2 31669.8 30030.5 30243.5 30788.5 31412.0 31648.7 28850.1 28859.7 29029.0 31241.4 32143.2 27429.9 28584.0 29181.4 29355.1 29511.2 22444.3 22631.3 22772.4 22809.7 22957.5 00:17:32 INFO - PROCESS | 12769 | 00:17:32 INFO - PROCESS | 12769 | [#2] jquery.html Cycles:180 Average:22557.60 Median:4441.05 stddev:56068.24 (1262.5%) stddev-sans-first:56200.79 00:17:32 INFO - PROCESS | 12769 | Values: 372.2 376.3 378.0 378.3 393.2 15210.3 15242.6 16597.3 16669.2 16671.2 15577.4 15884.4 16303.0 16410.6 16421.3 4813.3 5021.9 5042.6 5051.3 5052.1 4969.6 5054.2 5057.6 5064.4 5064.5 4735.7 4839.4 4852.0 4856.5 4891.1 4928.1 4932.6 4940.3 4942.1 4943.0 4270.9 4449.8 4482.0 4485.1 4487.0 19385.9 19805.6 19959.1 20010.3 20171.2 1850.0 1937.3 2016.3 2095.9 2169.2 8630.6 9161.1 12761.1 12877.0 13358.1 1683.5 1689.3 1741.5 1771.0 1779.5 67903.7 69844.3 69898.3 71554.0 71689.0 9606.6 9813.8 9837.4 9977.3 10060.5 13776.7 13787.1 13792.5 13806.0 13808.3 6536.2 6705.1 6775.3 6877.3 6891.6 6219.1 6234.7 6375.6 6379.7 6406.0 4238.2 4253.9 4289.6 4432.3 4457.0 1706.7 1734.1 1808.9 1830.1 1832.7 778.9 816.2 882.7 886.9 948.8 15623.6 16372.5 17164.0 17426.8 17496.6 825.6 834.8 860.3 867.8 873.9 7723.8 9328.3 9528.3 9762.7 9904.0 333213.0 336787.0 339216.0 339413.0 339522.0 71700.6 72516.0 72960.0 73188.6 75927.6 879.2 882.1 883.1 886.3 894.2 14681.6 14852.6 14918.7 14964.6 15534.8 34148.3 35586.3 35591.7 36497.3 38139.0 48329.3 49198.5 49416.3 49921.3 50273.7 7469.9 7544.7 7583.0 7619.7 7963.2 8555.7 11364.0 11493.2 11546.9 11918.5 9671.8 10225.2 10283.2 10377.0 10665.7 10059.4 10103.3 10349.1 10470.8 10763.5 10268.5 10278.7 10465.9 10676.9 10813.6 7470.8 7476.2 7480.3 7565.9 7594.5 8788.3 10234.4 10304.8 10405.4 10581.5 00:17:32 INFO - PROCESS | 12769 | 00:17:32 INFO - PROCESS | 12769 | [#3] mootools.html Cycles:180 Average:4763.13 Median:5640.63 stddev:2543.16 (45.1%) stddev-sans-first:2536.39 00:17:32 INFO - PROCESS | 12769 | Values: 1224.8 1306.0 1341.2 1420.6 1677.5 6085.6 6874.6 7077.0 7134.4 7297.1 7256.1 7335.7 7336.5 7343.4 7348.9 1852.1 1910.5 2107.7 2143.7 2152.5 2063.8 2137.8 2139.2 2144.8 2147.4 2057.5 2060.4 2062.6 2066.8 2066.8 2076.2 2092.4 2113.5 2125.6 2125.9 2063.8 2072.5 2086.4 2093.9 2094.1 7122.0 7212.1 7337.8 7339.3 7342.4 4270.2 4410.6 4413.9 4415.1 4415.1 2785.6 2934.9 2946.9 2955.1 3022.4 872.1 904.5 921.7 965.6 970.1 9480.1 9491.1 9502.5 9587.5 9707.5 3896.1 4076.1 4131.3 4157.2 4206.5 7950.3 7960.5 7962.1 7973.6 7974.0 4440.0 4440.6 4520.1 4525.4 4530.5 3658.2 3866.8 4044.6 4046.5 4047.2 3339.0 3394.6 3476.4 3499.8 3519.3 1146.3 1180.9 1180.9 1184.0 1184.0 828.3 831.2 831.2 870.9 871.9 4710.2 4950.4 5008.7 5087.7 5109.6 771.7 822.2 829.5 833.5 843.7 3274.9 3295.8 3336.4 3347.3 3377.9 8271.7 8565.4 8635.4 8639.7 8664.7 8579.7 8581.2 8583.3 8588.5 8590.4 6335.7 6621.1 6639.4 6802.4 6816.6 4742.0 4743.1 4812.1 4883.5 5223.3 7852.1 7944.0 8018.8 8050.2 8076.7 7791.5 7924.4 7960.1 8017.3 8066.8 5547.1 5734.1 5993.3 6105.6 6142.6 6637.1 6948.9 6953.2 7164.6 7165.2 6203.9 6430.7 6434.2 6583.9 6633.3 6190.0 6200.0 6217.1 6228.8 6239.9 5974.3 6091.4 6098.2 6100.8 6104.3 4388.1 4534.7 4562.0 4578.9 4606.5 4425.3 4470.7 4580.3 4596.4 4688.0 00:17:32 INFO - PROCESS | 12769 | 00:17:32 INFO - PROCESS | 12769 | [#4] prototype.html Cycles:180 Average:4197.82 Median:4726.23 stddev:1170.47 (24.8%) stddev-sans-first:1137.62 00:17:32 INFO - PROCESS | 12769 | Values: 352.9 355.6 357.7 359.5 361.1 4782.5 4809.4 4816.9 4820.2 4823.9 4766.1 4773.8 4782.7 4792.8 4805.4 3717.0 3791.8 3793.4 3812.5 3848.1 3853.9 3858.8 3877.1 3878.2 3892.4 3845.3 3858.6 3861.9 3862.5 3873.9 3660.7 3696.8 3775.5 3872.2 3873.3 3471.3 3480.5 3497.7 3502.0 3507.9 4664.5 4675.5 4679.0 4679.4 4693.5 4299.3 4415.4 4418.5 4424.3 4426.6 4962.2 4985.0 5014.8 5016.3 5028.2 3786.8 3799.4 3801.0 3813.0 3814.0 5110.3 5242.3 5258.2 5265.4 5278.4 3880.8 3907.8 3908.8 3913.2 3913.6 3961.8 3970.2 3980.5 3981.0 3982.4 4342.5 4349.2 4367.1 4379.5 4380.8 4891.9 4949.8 4992.4 5007.4 5036.5 1333.6 1342.2 1344.8 1345.4 1346.6 924.9 960.7 965.4 971.3 973.2 4199.2 4311.6 4314.9 4327.2 4339.4 5007.8 5024.0 5032.2 5148.6 5149.4 4413.0 4420.9 4429.8 4434.8 4444.2 2582.8 2653.3 2667.5 2672.3 2688.7 4669.6 4706.8 4722.9 4729.5 4739.4 5124.5 5131.2 5144.2 5151.5 5153.9 4504.2 4701.4 4776.8 4785.6 4804.2 5032.8 5056.8 5095.8 5099.9 5102.9 4940.0 4961.4 4962.3 4972.9 4973.9 4600.8 4802.7 4903.0 4904.1 4911.4 3624.5 3657.2 3684.5 3685.9 3694.4 5201.4 5202.3 5213.3 5217.8 5218.7 4963.6 5044.5 5073.0 5076.1 5084.0 5055.7 5071.9 5074.3 5076.7 5079.3 4970.7 4977.6 4983.7 4984.1 5000.5 4819.7 4875.7 4926.7 5037.3 5081.0 4801.4 4941.8 4956.7 4966.0 4977.4 00:17:32 INFO - PROCESS | 12769 | 00:17:32 INFO - PROCESS | 12769 | [#5] yui.html Cycles:180 Average:14527.92 Median:43390.39 stddev:17248.58 (39.8%) stddev-sans-first:17265.35 00:17:32 INFO - PROCESS | 12769 | Values: 620.4 688.1 727.8 734.0 747.0 12618.6 13537.8 13558.3 13562.4 13586.7 13223.0 13389.0 13414.1 13426.8 14378.1 613.4 639.1 749.8 767.3 784.4 786.9 787.5 788.3 789.2 790.1 820.9 821.5 821.7 821.8 821.9 644.5 668.0 780.6 809.9 816.6 607.3 607.5 607.6 607.7 608.0 13213.3 13416.3 13418.1 13442.1 13450.8 12245.4 12501.7 12635.4 12724.6 12859.8 11925.0 11926.5 11943.4 12184.6 12247.7 4040.8 4069.2 4113.9 4138.5 4150.9 64374.0 64400.0 64820.7 64918.0 66790.0 10519.7 10523.9 10937.6 10950.6 11161.0 18788.0 19324.3 20266.5 20269.8 20307.8 7006.2 7142.2 7306.7 7357.6 7437.2 3625.8 3678.1 3685.8 3721.8 3725.1 3093.1 3154.2 3171.9 3174.4 3178.7 534.7 536.3 548.8 549.8 552.7 513.7 637.6 638.5 649.4 666.7 8482.9 8486.5 8557.4 8606.4 8743.1 537.0 545.6 597.5 597.7 621.3 3929.2 4165.1 4270.9 4291.2 4308.7 52555.5 53091.0 54072.0 60845.0 69284.3 44692.0 47655.8 51268.7 52259.0 52991.0 47812.0 48317.5 49465.8 50323.0 51095.5 8732.3 9198.4 9335.5 9430.8 9480.9 31200.2 31893.5 32326.4 33461.3 34726.5 43224.8 43556.0 44804.3 45641.3 47954.0 10620.0 11287.3 11618.3 11654.2 11816.6 12719.9 12895.9 13238.7 14086.9 14210.2 11435.8 12112.8 12448.9 12615.3 12886.2 11577.8 12012.2 12447.9 12581.9 12949.7 11344.5 11814.5 12009.4 12021.7 12024.0 9802.4 10085.5 10324.2 10503.7 10544.9 8932.0 9272.6 9614.4 9915.9 10304.8 00:17:32 INFO - PROCESS | 12769 | -------- Summary: end -------- 00:17:32 INFO - PROCESS | 12769 | 00:17:33 INFO - TEST-INFO | 12769: exit 0 00:17:33 INFO - TEST-OK | dromaeo_css | took 1121332ms 00:17:33 INFO - TEST-START | kraken 00:17:33 INFO - operating with platform_type : linux_ 00:17:33 INFO - Initialising browser for kraken test... 00:17:33 INFO - TEST-INFO | started process 13069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_wMj2t/profile http://localhost:43301/getInfo.html) 00:17:37 INFO - PROCESS | 13069 | __metrics Screen width/height:1600/1200 00:17:37 INFO - PROCESS | 13069 | colorDepth:24 00:17:37 INFO - PROCESS | 13069 | Browser inner width/height: 1024/697 00:17:37 INFO - PROCESS | 13069 | __metrics 00:17:38 INFO - PROCESS | 13069 | 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" 00:17:38 INFO - PROCESS | 13069 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:17:38 INFO - PROCESS | 13069 | console.error: PushService: 00:17:38 INFO - PROCESS | 13069 | stateChangeProcessEnqueue: Error transitioning state 00:17:38 INFO - PROCESS | 13069 | UnknownError 00:17:39 INFO - TEST-INFO | 13069: exit 0 00:17:39 INFO - Browser initialized. 00:17:39 INFO - Running cycle 1/1 for kraken test... 00:17:39 INFO - TEST-INFO | started process 13152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_wMj2t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:17:51 INFO - PROCESS | 13152 | RSS: Main: 156033024 00:17:51 INFO - PROCESS | 13152 | 00:17:54 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43301/tests/kraken/driver.html?testName=audio-beat-detection) 00:17:55 INFO - PROCESS | 13152 | RSS: Main: 210030592 00:17:55 INFO - PROCESS | 13152 | 00:17:58 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43301/tests/kraken/driver.html?testName=audio-dft) 00:17:58 INFO - PROCESS | 13152 | RSS: Main: 187543552 00:17:58 INFO - PROCESS | 13152 | 00:18:01 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43301/tests/kraken/driver.html?testName=audio-fft) 00:18:02 INFO - PROCESS | 13152 | RSS: Main: 269946880 00:18:02 INFO - PROCESS | 13152 | 00:18:04 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43301/tests/kraken/driver.html?testName=audio-oscillator) 00:18:05 INFO - PROCESS | 13152 | RSS: Main: 181866496 00:18:05 INFO - PROCESS | 13152 | 00:18:07 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43301/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:18:08 INFO - PROCESS | 13152 | RSS: Main: 185233408 00:18:08 INFO - PROCESS | 13152 | 00:18:11 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43301/tests/kraken/driver.html?testName=imaging-darkroom) 00:18:11 INFO - PROCESS | 13152 | RSS: Main: 223920128 00:18:11 INFO - PROCESS | 13152 | 00:18:15 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43301/tests/kraken/driver.html?testName=imaging-desaturate) 00:18:15 INFO - PROCESS | 13152 | RSS: Main: 223875072 00:18:15 INFO - PROCESS | 13152 | 00:18:18 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43301/tests/kraken/driver.html?testName=json-parse-financial) 00:18:19 INFO - PROCESS | 13152 | RSS: Main: 222990336 00:18:19 INFO - PROCESS | 13152 | 00:18:21 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43301/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:18:21 INFO - PROCESS | 13152 | RSS: Main: 185069568 00:18:21 INFO - PROCESS | 13152 | 00:18:23 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43301/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:18:24 INFO - PROCESS | 13152 | RSS: Main: 192241664 00:18:24 INFO - PROCESS | 13152 | 00:18:26 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43301/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:18:27 INFO - PROCESS | 13152 | RSS: Main: 199999488 00:18:27 INFO - PROCESS | 13152 | 00:18:29 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:18:30 INFO - PROCESS | 13152 | RSS: Main: 209833984 00:18:30 INFO - PROCESS | 13152 | 00:18:33 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:18:34 INFO - PROCESS | 13152 | RSS: Main: 206245888 00:18:34 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | Cycle 1(1): loaded http://localhost:43301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43301/tests/kraken/driver.html?testName=ai-astar) 00:18:36 INFO - PROCESS | 13152 | RSS: Main: 257961984 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | __start_tp_report 00:18:36 INFO - PROCESS | 13152 | _x_x_mozilla_page_load 00:18:36 INFO - PROCESS | 13152 | _x_x_mozilla_page_load_details 00:18:36 INFO - PROCESS | 13152 | |i|pagename|runs| 00:18:36 INFO - PROCESS | 13152 | |0;ai-astar;113;116;116;116;115;115;113;113;115;114 00:18:36 INFO - PROCESS | 13152 | |1;audio-beat-detection;150;127;126;161;126;126;124;124;148;128 00:18:36 INFO - PROCESS | 13152 | |2;audio-dft;160;162;161;163;162;163;163;161;162;161 00:18:36 INFO - PROCESS | 13152 | |3;audio-fft;76;76;76;114;78;76;77;77;102;76 00:18:36 INFO - PROCESS | 13152 | |4;audio-oscillator;86;85;116;85;85;85;105;85;85;126 00:18:36 INFO - PROCESS | 13152 | |5;imaging-gaussian-blur;126;126;127;127;127;126;127;127;127;126 00:18:36 INFO - PROCESS | 13152 | |6;imaging-darkroom;146;146;147;148;147;148;148;147;147;146 00:18:36 INFO - PROCESS | 13152 | |7;imaging-desaturate;96;95;96;96;96;96;97;96;95;95 00:18:36 INFO - PROCESS | 13152 | |8;json-parse-financial;63;63;64;63;66;64;66;64;66;65 00:18:36 INFO - PROCESS | 13152 | |9;json-stringify-tinderbox;67;65;65;66;66;66;66;66;66;66 00:18:36 INFO - PROCESS | 13152 | |10;stanford-crypto-aes;85;85;94;90;84;95;88;84;84;85 00:18:36 INFO - PROCESS | 13152 | |11;stanford-crypto-ccm;147;155;135;139;139;140;134;133;177;138 00:18:36 INFO - PROCESS | 13152 | |12;stanford-crypto-pbkdf2;177;173;175;173;180;176;175;174;174;176 00:18:36 INFO - PROCESS | 13152 | |13;stanford-crypto-sha256-iterative;69;68;69;66;69;66;66;68;66;66 00:18:36 INFO - PROCESS | 13152 | __end_tp_report 00:18:36 INFO - PROCESS | 13152 | __start_cc_report 00:18:36 INFO - PROCESS | 13152 | _x_x_mozilla_cycle_collect,1993 00:18:36 INFO - PROCESS | 13152 | __end_cc_report 00:18:36 INFO - PROCESS | 13152 | __startTimestamp1482135516342__endTimestamp 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | ------- Summary: start ------- 00:18:36 INFO - PROCESS | 13152 | Number of tests: 14 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:1.26 (1.1%) stddev-sans-first:1.20 00:18:36 INFO - PROCESS | 13152 | Values: 113.0 116.0 116.0 116.0 115.0 115.0 113.0 113.0 115.0 114.0 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:127.50 stddev:13.57 (10.6%) stddev-sans-first:13.10 00:18:36 INFO - PROCESS | 13152 | Values: 150.0 127.0 126.0 161.0 126.0 126.0 124.0 124.0 148.0 128.0 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:0.87 00:18:36 INFO - PROCESS | 13152 | Values: 160.0 162.0 161.0 163.0 162.0 163.0 163.0 161.0 162.0 161.0 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:13.60 (17.9%) stddev-sans-first:14.20 00:18:36 INFO - PROCESS | 13152 | Values: 76.0 76.0 76.0 114.0 78.0 76.0 77.0 77.0 102.0 76.0 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:85.00 stddev:15.56 (18.3%) stddev-sans-first:16.21 00:18:36 INFO - PROCESS | 13152 | Values: 86.0 85.0 116.0 85.0 85.0 85.0 105.0 85.0 85.0 126.0 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#5] imaging-gaussian-blur Cycles:10 Average:126.60 Median:127.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 00:18:36 INFO - PROCESS | 13152 | Values: 126.0 126.0 127.0 127.0 127.0 126.0 127.0 127.0 127.0 126.0 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 00:18:36 INFO - PROCESS | 13152 | Values: 146.0 146.0 147.0 148.0 147.0 148.0 148.0 147.0 147.0 146.0 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 00:18:36 INFO - PROCESS | 13152 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 97.0 96.0 95.0 95.0 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:1.26 (2.0%) stddev-sans-first:1.24 00:18:36 INFO - PROCESS | 13152 | Values: 63.0 63.0 64.0 63.0 66.0 64.0 66.0 64.0 66.0 65.0 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 00:18:36 INFO - PROCESS | 13152 | Values: 67.0 65.0 65.0 66.0 66.0 66.0 66.0 66.0 66.0 66.0 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:86.50 stddev:4.22 (4.9%) stddev-sans-first:4.39 00:18:36 INFO - PROCESS | 13152 | Values: 85.0 85.0 94.0 90.0 84.0 95.0 88.0 84.0 84.0 85.0 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#11] stanford-crypto-ccm Cycles:10 Average:143.70 Median:139.50 stddev:13.43 (9.6%) stddev-sans-first:14.19 00:18:36 INFO - PROCESS | 13152 | Values: 147.0 155.0 135.0 139.0 139.0 140.0 134.0 133.0 177.0 138.0 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:175.50 stddev:2.11 (1.2%) stddev-sans-first:2.15 00:18:36 INFO - PROCESS | 13152 | Values: 177.0 173.0 175.0 173.0 180.0 176.0 175.0 174.0 174.0 176.0 00:18:36 INFO - PROCESS | 13152 | 00:18:36 INFO - PROCESS | 13152 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.42 (2.1%) stddev-sans-first:1.36 00:18:36 INFO - PROCESS | 13152 | Values: 69.0 68.0 69.0 66.0 69.0 66.0 66.0 68.0 66.0 66.0 00:18:36 INFO - PROCESS | 13152 | -------- Summary: end -------- 00:18:36 INFO - PROCESS | 13152 | 00:18:37 INFO - TEST-INFO | 13152: exit 0 00:18:37 INFO - TEST-OK | kraken | took 63783ms 00:18:37 INFO - SUITE-END | took 1185s 00:18:37 INFO - Completed test suite (00:19:45) 00:18:37 INFO - javascript benchmark 00:18:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2589.0938171639928, 2605.491929073829, 2621.3839747659304, 2637.947241055179, 2647.2984659065337, 4607.447106347243, 4650.162970665279, 4719.740414277213, 4743.501932297107, 4754.286856971452, 4695.272232803921, 4702.1065997460455, 4744.739039352834, 4807.639427042968, 4808.182608956477, 4292.313229883203, 4325.372820940962, 4338.284183109783, 4346.261135606938, 4414.889627759299, 3939.8424063037446, 4405.713628614146, 4439.311906654474, 4483.506814250446, 4520.97739511302, 4292.098659281554, 4334.631556317717, 4416.315471101984, 4449.71076880005, 4485.237509623355, 4353.216421044211, 4385.758783266919, 4396.560343965578, 4399.604035636776, 4462.0, 4365.3451982202605, 4375.278079116942, 4375.474943006828, 4384.0355121873135, 4420.270655341865, 4761.761911904391, 4772.809087636525, 4779.498152693986, 4787.234042553175, 4831.879203019917, 4932.926006109911, 4971.950280497221, 4974.651774375795, 5033.521815427529, 5068.746562671851, 5114.0, 5117.130087885069, 5119.206522988906, 5147.124988751922, 5154.072266991978, 4770.189067858438, 4772.689775164603, 4773.451053128934, 4776.546228108324, 4818.903621927612, 5119.10415677255, 5184.818531351385, 5187.507186817246, 5202.193659982709, 5265.473452654704, 4986.376702912136, 5003.624728145331, 5008.223725322508, 5027.170516864677, 5071.036503064406, 5102.8214012510125, 5103.979204159183, 5106.591472682177, 5108.361454818148, 5154.484551544815, 4971.328870602495, 5033.471485494044, 5066.670666406671, 5075.1625981712605, 5080.77136528857, 5001.799928002912, 5062.063518249136, 5062.139436295838, 5067.214581739836, 5070.340855688737, 4237.364395340724, 4264.616184543406, 4284.357346398003, 4290.420793192941, 4296.677749168824, 3737.1965027518672, 3742.3076730804887, 3768.566614839274, 3771.9622803771613, 3785.9432108518395, 4370.54109318517, 4372.060007098489, 4372.978135109304, 4381.846635367747, 4420.204363214588, 4964.1809101498575, 4966.925496117561, 5022.020705962303, 5125.1287281162295, 5169.4572069932865, 4330.415393921843, 4332.610065094157, 4348.195583817004, 4351.26028575143, 4407.537208593116, 4549.27211646135, 4554.886127846764, 4555.498895121534, 4557.430321209848, 4601.631869450436, 4646.0, 4773.451053128934, 4779.928301075417, 4779.976100119547, 4818.759062046954, 5003.299538064746, 5067.87330316745, 5081.974590127025, 5090.541851233407, 5097.158968770112, 4792.832250871203, 4797.088553174885, 4798.49615790337, 4822.42130944289, 4846.927296090632, 5028.220625803006, 5028.74856257193, 5030.698158110525, 5039.470855560114, 5041.571466425395, 4948.8762780930765, 5004.124278251219, 5005.34930459038, 5031.446540880427, 5109.718965456936, 4921.50784921505, 4973.079980203674, 4973.52751488608, 4990.201567749143, 5008.223725322581, 4967.428745694291, 4970.950290497193, 4975.776090076028, 4978.303037574815, 4978.8257410990445, 4752.881177970578, 4793.089313030513, 4803.375561177025, 4840.7337596431125, 4874.488178741181, 4916.729579873141, 4969.602431805519, 4978.726170060681, 4979.3526841510375, 5033.496650334937, 4781.330613714013, 4821.445533763522, 4859.635527335393, 4869.0261947609915, 4917.483664215206], "value": 4656.877517393493, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.4577193946357, 536.9543588794952, 547.2830591924579, 550.3038656100032, 551.2585572405115, 29410.117696469115, 37004.0, 38418.615813841854, 38581.228375432474, 42053.7897310513, 38992.22015559687, 39296.21407571847, 39366.40950385747, 39377.40933885994, 39466.408003879966, 7202.17175024871, 7538.88691669624, 7749.457537972344, 7770.766876993699, 7772.300492955633, 7158.46311526635, 9491.098345657152, 9792.559334829913, 9797.804043919117, 10125.59497620098, 10005.249606279522, 10075.244356673242, 10076.94961525195, 10078.949605251963, 10082.04220599042, 10014.799704005916, 10081.243906706954, 10083.042110999444, 10084.092431681183, 10095.29332946694, 9870.753231169207, 9950.651727189586, 9950.9502452488, 9954.900450995543, 9959.103680668703, 35938.0, 36200.818995905116, 36214.275714485826, 36225.81887090574, 36270.8186459066, 2850.2161905475955, 2879.5536691812804, 2898.2899189698446, 3023.4104349651825, 3315.2043509557775, 27628.723712762818, 27899.0, 28163.85918070417, 28254.71745282562, 29015.709842901513, 3327.73378129749, 3338.115399419156, 3372.1738174147245, 3414.7268218542704, 3444.9483257751153, 234381.0, 235227.99999999828, 236619.0, 236815.0, 237461.0, 50972.745136274825, 51273.23090153651, 51666.741666291426, 51685.48314516882, 51702.741486292325, 53797.041162735644, 53866.0, 53873.73063134659, 53922.0, 53942.46057539453, 14123.78814317786, 14703.926480367743, 14745.1890146043, 14844.62888427798, 14850.183239921907, 10078.949605251926, 10391.48042597867, 10612.787744245072, 11334.43327833605, 11401.714957125972, 15112.622184445478, 15350.616234594001, 15464.458743943907, 15694.215289235493, 15926.124063176405, 5601.859953501195, 5813.94186058134, 5828.59199856006, 5871.882562348729, 5880.26496687914, 834.7120243515977, 836.9037560680478, 856.9571521423904, 877.1141147441003, 917.8623206519076, 25655.230343089737, 27712.307192320353, 27879.0, 27906.16281511558, 27959.58060629092, 851.7913111287775, 857.9056303806576, 873.2446433834688, 874.8643960186181, 1000.6647772996128, 14211.857881421054, 14575.562733118024, 14637.560873173821, 14719.55841324762, 14957.626059348604, 326442.0, 327138.0, 329818.0, 330728.0, 331155.0, 48135.0, 48301.75849120732, 48340.516594834306, 48392.51607483951, 48393.27410088851, 1047.4657924458581, 1088.1838621034383, 1103.690966529373, 1174.0607513988775, 1175.0129890891692, 25809.225723228334, 28128.71871281261, 28143.57784633191, 30396.696033039385, 31097.8445107773, 45701.0, 46377.53622463732, 46424.767876160404, 46493.53506464892, 46513.30230046484, 301685.0, 305873.0, 306151.0, 306315.0, 307040.0, 22218.222362217246, 23104.653430198898, 24171.395715107265, 24325.391865202804, 35256.47115293324, 36115.81942090273, 36146.819265903505, 36303.636963631085, 36433.81783091067, 36662.8166859164, 30638.234044149074, 30722.231944201572, 30888.53667194949, 31073.223169420944, 31669.841650791597, 30030.549541756453, 30243.546346804374, 30788.53817192789, 31412.0, 31648.683513164575, 28850.134495965154, 28859.711402885703, 29028.983985560404, 31241.37517249688, 32143.19642008875, 27429.86285068562, 28584.0, 29181.41637167202, 29355.11934641964, 29511.202339611875, 22444.32667019992, 22631.321060368216, 22772.4306892329, 22809.657855131853, 22957.540849183257], "value": 17032.373617999743, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.19791349641497, 376.3338890164409, 377.9811009449527, 378.2774899941112, 393.1527558112267, 15210.326864044946, 15242.618934526643, 16597.25312360945, 16669.24988375523, 16671.1664416779, 15577.376904923818, 15884.444044458418, 16303.0, 16410.589735256624, 16421.343146274136, 4813.302071199674, 5021.924671129936, 5042.571381432583, 5051.292819005343, 5052.115879721053, 4969.627277954168, 5054.21659642756, 5057.5701065409485, 5064.392272927235, 5064.468230835746, 4735.715857048588, 4839.419269687643, 4851.951480485203, 4856.538628830255, 4891.1195984722735, 4928.137575924216, 4932.556069953685, 4940.25896115582, 4942.061008408409, 4943.0, 4270.850520231777, 4449.7997590108525, 4482.0, 4485.1254005468945, 4486.955130448719, 19385.9030704847, 19805.60388792216, 19959.101840417217, 20010.29963951255, 20171.193152274038, 1849.9907500462411, 1937.2541571494935, 2016.264063616784, 2095.9371218863457, 2169.197396963118, 8630.568471576458, 9161.083891610851, 12761.106722529426, 12877.0, 13358.131721438076, 1683.46970704229, 1689.2567270400984, 1741.547197728587, 1770.9645807083914, 1779.5373202967191, 67903.66048169727, 69844.30155698428, 69898.30101698969, 71554.0, 71689.0, 9606.567704453317, 9813.80372392548, 9837.409755414697, 9977.301588888708, 10060.523067235157, 13776.724465510633, 13787.103838250481, 13792.517261895986, 13806.0, 13808.309584520734, 6536.150300460909, 6705.1110355993405, 6775.254721980578, 6877.277885822016, 6891.586504809728, 6219.129321894939, 6234.719437625317, 6375.6174629522375, 6379.74481020754, 6406.039094135824, 4238.19474299882, 4253.8723838284905, 4289.635380992589, 4432.29083346663, 4456.955430445719, 1706.7013272677232, 1734.1329335332334, 1808.9276428942694, 1830.1306879232259, 1832.743415921772, 778.8792737125755, 816.1512027491342, 882.7042940614838, 886.8980067292215, 948.8244674735196, 15623.60940976462, 16372.50882473504, 17164.0, 17426.825731742774, 17496.562585935455, 825.5995842016617, 834.7746108550779, 860.3289434241302, 867.7960679240374, 873.9475631462133, 7723.7682869514, 9328.347015708836, 9528.285378596633, 9762.707118786448, 9903.950480247697, 333213.0, 336787.0, 339216.0, 339413.0, 339522.0, 71700.64149679219, 72516.0, 72960.0, 73188.63405682938, 75927.62036189894, 879.1691851200682, 882.0826340605827, 883.0683628771708, 886.3396769406833, 894.1594900793234, 14681.632959176106, 14852.62868428298, 14918.701625967637, 14964.625884352978, 15534.84465155334, 34148.31703365869, 35586.288274233855, 35591.686540374794, 36497.27005459929, 38139.0, 48329.27506087341, 49198.50801492082, 49416.25875611797, 49921.251181233034, 50273.74863125661, 7469.88795168062, 7544.660490277841, 7582.962085189539, 7619.69521219145, 7963.203679631991, 8555.700550480704, 11364.0, 11493.195476316912, 11546.884531154581, 11918.52325906954, 9671.758206044906, 10225.233107517115, 10283.177345812168, 10377.0, 10665.680029599125, 10059.446730429896, 10103.343282686601, 10349.068583827491, 10470.790584188426, 10763.51564179598, 10268.537915793659, 10278.743031423975, 10465.895341046797, 10676.946615266874, 10813.567457301935, 7470.813229669085, 7476.214997425192, 7480.289372509603, 7565.886511702219, 7594.5063570867715, 8788.252998494943, 10234.385936843813, 10304.793904121725, 10405.375677459377, 10581.523831427758], "value": 7988.902935638886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1224.755048990201, 1305.9608211753648, 1341.1626072280974, 1420.5738278516449, 1677.4548271811664, 6085.604435711675, 6874.55315404499, 7076.964615176923, 7134.357907788311, 7297.124345078585, 7256.092988376453, 7335.669894854731, 7336.486445948785, 7343.4492413068965, 7348.926510734891, 1852.0924746874002, 1910.503269150017, 2107.725995620571, 2143.732033495813, 2152.461884528868, 2063.793620637939, 2137.7969092936146, 2139.155033761663, 2144.774798646143, 2147.377260594426, 2057.506198512361, 2060.4127823570284, 2062.618415593113, 2066.7829877862832, 2066.8243199328076, 2076.2110398048794, 2092.424583239606, 2113.471632091977, 2125.6067627488965, 2125.90433430496, 2063.793620637939, 2072.523319636477, 2086.405374468284, 2093.926712565068, 2094.099537199004, 7122.002919591261, 7212.134543854771, 7337.816554586125, 7339.339459448622, 7342.375898048672, 4270.167317373113, 4410.62509686677, 4413.889652758675, 4415.072834704716, 4415.094905544356, 2785.5960885671466, 2934.9119526414243, 2946.882124715009, 2955.069153216751, 3022.3955208958077, 872.1409411729442, 904.4980036079972, 921.7050543825978, 965.5944503308627, 970.1462712812751, 9480.099390557885, 9491.098345657152, 9502.524873756354, 9587.520623968774, 9707.466089365082, 3896.08442016126, 4076.0828813516723, 4131.29767939451, 4157.230912281178, 4206.495220573551, 7950.324222441157, 7960.4825686330205, 7962.084360298524, 7973.60131993398, 7974.003249593801, 4439.955600444019, 4440.644748420119, 4520.118576877478, 4525.366448697185, 4530.456345238526, 3658.231771328051, 3866.8259928303296, 4044.6157615027114, 4046.47395838545, 4047.170330082326, 3338.966610333914, 3394.575678040245, 3476.43560397822, 3499.825008749603, 3519.296140771805, 1146.3465824480134, 1180.8523934508187, 1180.887815657511, 1183.952641894332, 1183.9822402663967, 828.2918105020121, 831.1921570584076, 831.2061980808313, 870.856308709056, 871.904090550039, 4710.175719249118, 4950.381202349707, 5008.749562521933, 5087.694738315713, 5109.591232701375, 771.6566128073066, 822.2394285286206, 829.5478963964654, 833.5123952487742, 843.7343984023964, 3274.8526316315824, 3295.7692961492467, 3336.366090442808, 3347.330533893231, 3377.865906555955, 8271.710490132817, 8565.400421970528, 8635.438696484709, 8639.740807775777, 8664.696735614223, 8579.742607721779, 8581.184787445183, 8583.270422014073, 8588.484690918565, 8590.398672093019, 6335.714892829834, 6621.112982799879, 6639.402453779183, 6802.353776391334, 6816.625085620339, 4741.952580474152, 4743.146233677971, 4812.109759694467, 4883.461709561477, 5223.3209682741, 7852.097008844056, 7944.0, 8018.759437216893, 8050.154733752872, 8076.676932922617, 7791.4935529190425, 7924.445288829726, 7960.084590271961, 8017.318527925192, 8066.83866322682, 5547.11246200606, 5734.139879018181, 5993.340732519332, 6105.603135796159, 6142.600730952474, 6637.103990961158, 6948.895766563607, 6953.20038195614, 7164.570125792469, 7165.176004759519, 6203.906941395792, 6430.678466076771, 6434.163558737334, 6583.934160658524, 6633.336666333328, 6190.0, 6199.969000154971, 6217.129601855653, 6228.750849966132, 6239.937600624117, 5974.2830860297045, 6091.42131497507, 6098.237720284965, 6100.755969761338, 6104.298005729221, 4388.144311859284, 4534.727916325031, 4561.977190114028, 4578.885527861697, 4606.470255920612, 4425.3140763181755, 4470.664700147437, 4580.290055041474, 4596.448426188878, 4687.99208170245], "value": 3901.083633226699, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.88002079293034, 355.62303957804727, 357.7156160852122, 359.5308122899616, 361.0540384193415, 4782.52174782522, 4809.374781278438, 4816.855494335171, 4820.180569303218, 4823.94982132594, 4766.1182681204, 4773.785179666915, 4782.736949467778, 4792.83225087122, 4805.447373552042, 3717.0, 3791.810409479515, 3793.4499497572833, 3812.4662547243406, 3848.1149335652817, 3853.9148502587345, 3858.8070596470207, 3877.108265099029, 3878.2437424702193, 3892.377219644857, 3845.3078445879732, 3858.5562660294004, 3861.884143475686, 3862.4978752762104, 3873.888730641807, 3660.7071434285326, 3696.77819330841, 3775.528058992626, 3872.244912242114, 3873.2640798248244, 3471.3337597952873, 3480.460528618068, 3497.6852083312624, 3501.9513584553065, 3507.894763157084, 4664.463586687541, 4675.509071547506, 4679.0, 4679.391679081732, 4693.530646935314, 4299.312110062407, 4415.359772832953, 4418.536053714346, 4424.336349547593, 4426.627745398937, 4962.230854217602, 4984.975075124601, 5014.774335154927, 5016.322796422509, 5028.245763135559, 3786.8106594670157, 3799.411091280856, 3800.9619903801163, 3812.980935095307, 3813.9809300953593, 5110.259012443249, 5242.318498595158, 5258.212207849349, 5265.420803711627, 5278.419373868871, 3880.8059597020037, 3907.785071821077, 3908.843646254175, 3913.1977944521304, 3913.5890731473355, 3961.7622942623534, 3970.225805967866, 3980.5024371953505, 3981.029390451745, 3982.4424580558743, 4342.457192850894, 4349.217140914602, 4367.082912588328, 4379.474463064453, 4380.802863871069, 4891.926621100686, 4949.82675606352, 4992.400911890524, 5007.4491805901325, 5036.546710796046, 1333.6265845563257, 1342.2416334770824, 1344.7848344264871, 1345.401296423102, 1346.5556366399064, 924.8751418558543, 960.706984369774, 965.4070783207624, 971.2861047130353, 973.1533565797802, 4199.181159673895, 4311.633511151587, 4314.893276840669, 4327.17783621111, 4339.414179085846, 5007.84819491519, 5024.0, 5032.194848824171, 5148.562372198405, 5149.433562308143, 4412.955061007894, 4420.889477763018, 4429.7785110744335, 4434.756088415168, 4444.155610434007, 2582.806289528293, 2653.349929267303, 2667.519846427662, 2672.3319170207446, 2688.7094194786614, 4669.60308373792, 4706.811727530929, 4722.929156062662, 4729.527047295312, 4739.3933336664695, 5124.5131712487255, 5131.230315452712, 5144.202648589399, 5151.459096794858, 5153.922691159635, 4504.234280172379, 4701.435827700698, 4776.808927642995, 4785.588251465826, 4804.231322988305, 5032.798688052583, 5056.797728090835, 5095.77069031887, 5099.898002040012, 5102.938237057736, 4939.97530012362, 4961.4371472985895, 4962.33008543842, 4972.8508144755715, 4973.850784476472, 4600.792964316681, 4802.727277271596, 4902.975485122552, 4904.117258893433, 4911.435184953633, 3624.4563315502887, 3657.23198128396, 3684.5394325709285, 3685.852565897334, 3694.4458331250526, 5201.401838788436, 5202.3497062867145, 5213.270142180022, 5217.843464696065, 5218.739063046908, 4963.5780958618925, 5044.468871789835, 5073.0, 5076.137056700296, 5084.0, 5055.6713813602, 5071.898562028812, 5074.310615373858, 5076.695398276115, 5079.292116754716, 4970.676906001098, 4977.576905963034, 4983.725895075806, 4984.127777638826, 5000.524950129732, 4819.7108173509705, 4875.658703890836, 4926.679765815211, 5037.294778730908, 5080.974595127149, 4801.351817504732, 4941.77762000718, 4956.744681170131, 4965.975170124127, 4977.352944117241], "value": 3846.876479490211, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.4151321732397, 688.1329524798749, 727.7671145233527, 734.0310789757519, 747.0363231431454, 12618.621441356763, 13537.796933045987, 13558.254296013716, 13562.389692463837, 13586.728265434685, 13223.0, 13389.0, 13414.12808167471, 13426.798598021012, 14378.06542574732, 613.4233820208989, 639.143547646154, 749.7975546602414, 767.3017554025838, 784.4234487651571, 786.8977032985704, 787.5392895156341, 788.2944764435855, 789.2107892107892, 790.1229635105029, 820.8932838730957, 821.5440430561036, 821.704186492862, 821.7740121466614, 821.9095899451086, 644.5488158289216, 668.0, 780.6331024418514, 809.9190080991913, 816.6080281464871, 607.2621764556086, 607.5230943709167, 607.6475644126396, 607.7204485936475, 607.9756809727605, 13213.273269970148, 13416.262105584188, 13418.060735748502, 13442.12626179305, 13450.798238026437, 12245.387730613524, 12501.74996500074, 12635.43140558677, 12724.554640587536, 12859.807102893465, 11925.0, 11926.522939082426, 11943.448825169238, 12184.57353992606, 12247.69380765488, 4040.7575545467366, 4069.2065047315787, 4113.876583702494, 4138.482689663792, 4150.91698166038, 64374.0, 64400.0, 64820.67589662022, 64918.0, 66790.0, 10519.737006574744, 10523.94738026305, 10937.56249750001, 10950.616728414467, 11161.0, 18788.0, 19324.32364867223, 20266.493337666678, 20269.797302027087, 20307.79692203059, 7006.229314775371, 7142.21435642079, 7306.7077316906725, 7357.632118394166, 7437.219091995263, 3625.800580968072, 3678.08047988003, 3685.7788532688123, 3721.832517536717, 3725.068732816796, 3093.133922501703, 3154.1799132225788, 3171.920701982469, 3174.365126974614, 3178.698023687746, 534.6631622078066, 536.3269097282963, 548.7804878048812, 549.8020712543481, 552.6960171905436, 513.7225898015105, 637.5772066148709, 638.4605008767584, 649.3993056422885, 666.6500087454125, 8482.915170848337, 8486.533240671699, 8557.358198135165, 8606.397552171413, 8743.114772125184, 536.9931378665003, 545.6098889294174, 597.4563147535808, 597.7160848596968, 621.3351713666334, 3929.214157168578, 4165.10450253191, 4270.871873843727, 4291.2275790358035, 4308.698391112592, 52555.47444525582, 53091.0, 54072.0, 60845.0, 69284.30715692778, 44692.0, 47655.76172119117, 51268.743656282226, 52259.0, 52991.0, 47812.04375912462, 48317.516824832004, 49465.75267123641, 50323.0, 51095.489045109076, 8732.257758090633, 9198.402103863495, 9335.486548239913, 9430.796884361947, 9480.85778713306, 31200.21999450032, 31893.521597175597, 32326.35347293088, 33461.330773384885, 34726.47910281398, 43224.783876080415, 43556.0, 44804.32793508035, 45641.31538026999, 47954.0, 10620.0, 11287.266327688674, 11618.302901825917, 11654.18420710576, 11816.645500634995, 12719.87280127187, 12895.935520322339, 13238.735225295248, 14086.859131408555, 14210.218437985597, 11435.771284574428, 12112.75774484523, 12448.937755311166, 12615.30615816139, 12886.226826390446, 11577.768444631229, 12012.159148859846, 12447.883859744046, 12581.93709031449, 12949.676258093623, 11344.546218151512, 11814.527418903148, 12009.36235196678, 12021.699457513632, 12024.0, 9802.36284641496, 10085.495725213563, 10324.22568307365, 10503.684889453329, 10544.89455105439, 8931.955340223258, 9272.582733777132, 9614.423134611945, 9915.851262230928, 10304.793904122025], "value": 6385.783093785451, "unit": "score"}], "name": "dromaeo_css", "value": 6269.541076679809, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 116.0, 116.0, 115.0, 115.0, 113.0, 113.0, 115.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 126.0, 161.0, 126.0, 126.0, 124.0, 124.0, 148.0, 128.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 163.0, 162.0, 163.0, 163.0, 161.0, 162.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 114.0, 78.0, 76.0, 77.0, 77.0, 102.0, 76.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 116.0, 85.0, 85.0, 85.0, 105.0, 85.0, 85.0, 126.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 127.0, 127.0, 127.0, 126.0, 127.0, 127.0, 127.0, 126.0], "value": 126.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 66.0, 64.0, 66.0, 64.0, 66.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 94.0, 90.0, 84.0, 95.0, 88.0, 84.0, 84.0, 85.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 155.0, 135.0, 139.0, 139.0, 140.0, 134.0, 133.0, 177.0, 138.0], "value": 143.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 173.0, 175.0, 173.0, 180.0, 176.0, 175.0, 174.0, 174.0, 176.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 66.0, 69.0, 66.0, 66.0, 68.0, 66.0, 66.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1560.9, "alertThreshold": 2.0}]} 00:18:38 INFO - Return code: 0 00:18:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:18:38 INFO - # TBPL SUCCESS # 00:18:38 INFO - Running post-action listener: _resource_record_post_action 00:18:38 INFO - [mozharness: 2016-12-19 08:18:38.144954Z] Finished run-tests step (success) 00:18:38 INFO - Running post-run listener: _resource_record_post_run 00:18:38 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401715200; Read time: 16; Write time: 234004 00:18:38 INFO - TinderboxPrint: CPU usage
13.1% 00:18:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 00:18:38 INFO - TinderboxPrint: I/O write bytes / time
401,715,200 / 234,004 00:18:38 INFO - TinderboxPrint: CPU idle
8,336.2 (86.9%) 00:18:38 INFO - TinderboxPrint: CPU user
1,211.9 (12.6%) 00:18:38 INFO - TinderboxPrint: Swap in / out
0 / 0 00:18:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110297088; Read time: 0; Write time: 63104 00:18:38 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 290291712; Read time: 0; Write time: 170868 00:18:38 INFO - Running post-run listener: _upload_blobber_files 00:18:38 INFO - Blob upload gear active. 00:18:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:18:38 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 00:18:38 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'] 00:18:38 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 00:18:39 INFO - (blobuploader) - INFO - Open directory for files ... 00:18:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:18:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:18:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:18:40 INFO - (blobuploader) - INFO - Done attempting. 00:18:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:18:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:18:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:18:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:18:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:18:41 INFO - (blobuploader) - INFO - Done attempting. 00:18:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:18:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:18:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:18:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:18:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:18:44 INFO - (blobuploader) - INFO - Done attempting. 00:18:44 INFO - (blobuploader) - INFO - Iteration through files over. 00:18:44 INFO - Return code: 0 00:18:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:18:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:18:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/54bd90af4f997b242a6fe18976c61419d84c623fc5f3d9adb006ffe8d1e4e6ec63c715e5c600c504c06b24f62c75881c8985e443590e992bfff6525fe9948988", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9f427402be682236dc5cdbfe3c8d158e743386d683ba44f1447314a66a071ba88256376fe6ecfa82ad5f0c75c4fe08202277e9888921b544607e4aa63736ccc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e3146e79a76cd3505829b970de6273e51876293c9eb1f4809aa59e1ddb148844e82d25cc3cd662d359a3b1f79c82d5b9d67d008125f0264f6b15f7b97622b7df"} 00:18:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:18:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:18:44 INFO - Contents: 00:18:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/54bd90af4f997b242a6fe18976c61419d84c623fc5f3d9adb006ffe8d1e4e6ec63c715e5c600c504c06b24f62c75881c8985e443590e992bfff6525fe9948988", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9f427402be682236dc5cdbfe3c8d158e743386d683ba44f1447314a66a071ba88256376fe6ecfa82ad5f0c75c4fe08202277e9888921b544607e4aa63736ccc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e3146e79a76cd3505829b970de6273e51876293c9eb1f4809aa59e1ddb148844e82d25cc3cd662d359a3b1f79c82d5b9d67d008125f0264f6b15f7b97622b7df"} 00:18:44 INFO - Running post-run listener: copy_logs_to_upload_dir 00:18:44 INFO - Copying logs to upload dir... 00:18:44 INFO - mkdir: /builds/slave/test/build/upload/logs 00:18:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.638935 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-19 00:18:43.784779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 00:18:43.787892) ========= 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=6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455 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/54bd90af4f997b242a6fe18976c61419d84c623fc5f3d9adb006ffe8d1e4e6ec63c715e5c600c504c06b24f62c75881c8985e443590e992bfff6525fe9948988", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9f427402be682236dc5cdbfe3c8d158e743386d683ba44f1447314a66a071ba88256376fe6ecfa82ad5f0c75c4fe08202277e9888921b544607e4aa63736ccc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e3146e79a76cd3505829b970de6273e51876293c9eb1f4809aa59e1ddb148844e82d25cc3cd662d359a3b1f79c82d5b9d67d008125f0264f6b15f7b97622b7df"} build_url:https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011538 build_url: 'https://queue.taskcluster.net/v1/task/FcjgRUzxQs6w8DoMU8G7eQ/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/54bd90af4f997b242a6fe18976c61419d84c623fc5f3d9adb006ffe8d1e4e6ec63c715e5c600c504c06b24f62c75881c8985e443590e992bfff6525fe9948988", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9f427402be682236dc5cdbfe3c8d158e743386d683ba44f1447314a66a071ba88256376fe6ecfa82ad5f0c75c4fe08202277e9888921b544607e4aa63736ccc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e3146e79a76cd3505829b970de6273e51876293c9eb1f4809aa59e1ddb148844e82d25cc3cd662d359a3b1f79c82d5b9d67d008125f0264f6b15f7b97622b7df"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 00:18:43.812391) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 00:18:43.812698) ========= 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=6d15e502d8e29d5d2676d664000001c3-1482131766.982405-230491455 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 00:18:43.897423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 00:18:43.897832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 00:18:43.898130) ========= ========= Total master_lag: 0.16 =========