builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1474635249.34 results: success (0) buildid: 20160923030450 builduid: ffbe44669f134d589b727d090fc72921 revision: 052d4d77cbcae9d168754a62e6f71fd9946743b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:09.338010) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:09.338500) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:09.338840) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:09.385044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:09.385378) ========= 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=cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 05:54:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 82.8M=0s 2016-09-23 05:54:10 (82.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105375 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:09.512602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:09.512946) ========= 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=cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016419 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:09.565479) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:09.565843) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 052d4d77cbcae9d168754a62e6f71fd9946743b0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 052d4d77cbcae9d168754a62e6f71fd9946743b0 --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=cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 05:54:10,422 truncating revision to first 12 chars 2016-09-23 05:54:10,422 Setting DEBUG logging. 2016-09-23 05:54:10,422 attempt 1/10 2016-09-23 05:54:10,422 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/052d4d77cbca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 05:54:10,923 unpacking tar archive at: mozilla-central-052d4d77cbca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.813055 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:10.396074) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:10.396548) ========= script_repo_revision: 052d4d77cbcae9d168754a62e6f71fd9946743b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:10.397448) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:10.398089) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 05:54:10.409337) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-23 05:54:10.409676) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:54:11 INFO - MultiFileLogger online at 20160923 05:54:11 in /builds/slave/test 05:54:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:54:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:54:11 INFO - {'append_to_log': False, 05:54:11 INFO - 'base_work_dir': '/builds/slave/test', 05:54:11 INFO - 'blob_upload_branch': 'Firefox', 05:54:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:54:11 INFO - 'branch': 'Firefox', 05:54:11 INFO - 'buildbot_json_path': 'buildprops.json', 05:54:11 INFO - 'config_files': ('talos/linux_config.py',), 05:54:11 INFO - 'default_actions': ('clobber', 05:54:11 INFO - 'read-buildbot-config', 05:54:11 INFO - 'download-and-extract', 05:54:11 INFO - 'populate-webroot', 05:54:11 INFO - 'create-virtualenv', 05:54:11 INFO - 'install', 05:54:11 INFO - 'run-tests'), 05:54:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:54:11 INFO - 'download_minidump_stackwalk': True, 05:54:11 INFO - 'download_symbols': 'ondemand', 05:54:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:54:11 INFO - 'tooltool.py': '/tools/tooltool.py', 05:54:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:54:11 INFO - '/tools/misc-python/virtualenv.py')}, 05:54:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:54:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:54:11 INFO - 'installer_path': 'installer.exe', 05:54:11 INFO - 'log_level': 'info', 05:54:11 INFO - 'log_name': 'talos', 05:54:11 INFO - 'log_to_console': True, 05:54:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:54:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:54:11 INFO - 'opt_config_files': (), 05:54:11 INFO - 'pip_index': False, 05:54:11 INFO - 'sps_profile': False, 05:54:11 INFO - 'sps_profile_interval': 0, 05:54:11 INFO - 'suite': 'dromaeojs', 05:54:11 INFO - 'system_bits': '32', 05:54:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:54:11 INFO - 'title': 'talos-linux64-ix-054', 05:54:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:54:11 INFO - 'use_talos_json': True, 05:54:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:54:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:54:11 INFO - 'work_dir': 'build'} 05:54:11 INFO - [mozharness: 2016-09-23 12:54:11.361594Z] Running clobber step. 05:54:11 INFO - Running pre-action listener: _resource_record_pre_action 05:54:11 INFO - Running main action method: clobber 05:54:11 INFO - rmtree: /builds/slave/test/build 05:54:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:54:11 INFO - Running post-action listener: _resource_record_post_action 05:54:11 INFO - [mozharness: 2016-09-23 12:54:11.821446Z] Finished clobber step (success) 05:54:11 INFO - [mozharness: 2016-09-23 12:54:11.821547Z] Running read-buildbot-config step. 05:54:11 INFO - Running pre-action listener: _resource_record_pre_action 05:54:11 INFO - Running main action method: read_buildbot_config 05:54:11 INFO - Using buildbot properties: 05:54:11 INFO - { 05:54:11 INFO - "project": "", 05:54:11 INFO - "product": "firefox", 05:54:11 INFO - "script_repo_revision": "production", 05:54:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:54:11 INFO - "repository": "", 05:54:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:54:11 INFO - "buildid": "20160923030450", 05:54:11 INFO - "stage_platform": "linux64-pgo", 05:54:11 INFO - "basedir": "/builds/slave/test", 05:54:11 INFO - "nightly_build": "True", 05:54:11 INFO - "buildnumber": 893, 05:54:11 INFO - "slavename": "talos-linux64-ix-054", 05:54:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:54:11 INFO - "platform": "ubuntu64_hw", 05:54:11 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:54:11 INFO - "branch": "mozilla-central", 05:54:11 INFO - "repo_path": "mozilla-central", 05:54:11 INFO - "revision": "052d4d77cbcae9d168754a62e6f71fd9946743b0", 05:54:11 INFO - "pgo_build": "True", 05:54:11 INFO - "builduid": "ffbe44669f134d589b727d090fc72921", 05:54:11 INFO - "slavebuilddir": "test" 05:54:11 INFO - } 05:54:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:54:11 INFO - Running post-action listener: _resource_record_post_action 05:54:11 INFO - [mozharness: 2016-09-23 12:54:11.824039Z] Finished read-buildbot-config step (success) 05:54:11 INFO - [mozharness: 2016-09-23 12:54:11.824126Z] Running download-and-extract step. 05:54:11 INFO - Running pre-action listener: _resource_record_pre_action 05:54:11 INFO - Running main action method: download_and_extract 05:54:11 INFO - mkdir: /builds/slave/test/build/tests 05:54: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')]} 05:54:11 INFO - trying https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:54:11 INFO - Downloading https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:54:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:54:12 INFO - Downloaded 1361 bytes. 05:54:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:54:12 INFO - Using the following test package requirements: 05:54:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:54:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:54:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:12 INFO - u'jsshell-linux-x86_64.zip'], 05:54:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:54:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:54:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:54:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:54:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:54:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:54:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:54:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:54:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:54:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:12 INFO - Fetch https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:54:13 INFO - Expected file size: 21942439 05:54:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:54:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:54:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:54:17 INFO - Fetch https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:54:17 INFO - Expected file size: 21942439 05:54:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:54:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:54:22 INFO - Fetch https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:54:23 INFO - Expected file size: 14414059 05:54: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')]} 05:54:24 INFO - trying https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:54:24 INFO - Downloading https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:54:26 INFO - Downloaded 59630684 bytes. 05:54:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:54:26 INFO - mkdir: /builds/slave/test/properties 05:54:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:54:26 INFO - Writing to file /builds/slave/test/properties/build_url 05:54:26 INFO - Contents: 05:54:26 INFO - build_url:https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:54:27 INFO - Running post-action listener: _resource_record_post_action 05:54:27 INFO - Running post-action listener: set_extra_try_arguments 05:54:27 INFO - [mozharness: 2016-09-23 12:54:27.446730Z] Finished download-and-extract step (success) 05:54:27 INFO - [mozharness: 2016-09-23 12:54:27.446956Z] Running populate-webroot step. 05:54:27 INFO - Running pre-action listener: _resource_record_pre_action 05:54:27 INFO - Running main action method: populate_webroot 05:54:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:54:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:54:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:54:27 INFO - '--tppagecycles', 05:54:27 INFO - '7'], 05:54:27 INFO - 'tests': ['tsvgm']}}, 05:54:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:54:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:54:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:54:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:54:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:54:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:54:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:27 INFO - 'talos_options': ['--disable-e10s'], 05:54:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:54:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:27 INFO - 'talos_options': ['--disable-e10s'], 05:54:27 INFO - 'tests': ['damp', 'tps']}, 05:54:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:27 INFO - 'tests': ['damp', 'tps']}, 05:54:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:54:27 INFO - 'tests': ['dromaeo_dom']}, 05:54:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:54:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:54:27 INFO - 'tests': ['basic_compositor_video']}, 05:54:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:54:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:54:27 INFO - 'tests': ['a11yr', 05:54:27 INFO - 'ts_paint', 05:54:27 INFO - 'tpaint', 05:54:27 INFO - 'sessionrestore', 05:54:27 INFO - 'sessionrestore_no_auto_restore', 05:54:27 INFO - 'tabpaint']}, 05:54:27 INFO - 'other-e10s': {'tests': ['a11yr', 05:54:27 INFO - 'ts_paint', 05:54:27 INFO - 'tpaint', 05:54:27 INFO - 'sessionrestore', 05:54:27 INFO - 'sessionrestore_no_auto_restore', 05:54:27 INFO - 'tabpaint']}, 05:54:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:54:27 INFO - 'ts_paint', 05:54:27 INFO - 'tpaint', 05:54:27 INFO - 'sessionrestore', 05:54:27 INFO - 'sessionrestore_no_auto_restore', 05:54:27 INFO - 'tabpaint']}, 05:54:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:54:27 INFO - 'ts_paint', 05:54:27 INFO - 'tpaint', 05:54:27 INFO - 'sessionrestore', 05:54:27 INFO - 'sessionrestore_no_auto_restore', 05:54:27 INFO - 'tabpaint']}, 05:54:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:54:27 INFO - 'tests': ['a11yr', 05:54:27 INFO - 'ts_paint', 05:54:27 INFO - 'tpaint', 05:54:27 INFO - 'sessionrestore', 05:54:27 INFO - 'sessionrestore_no_auto_restore', 05:54:27 INFO - 'tabpaint']}, 05:54:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:54:27 INFO - 'tests': ['a11yr', 05:54:27 INFO - 'ts_paint', 05:54:27 INFO - 'tpaint', 05:54:27 INFO - 'sessionrestore', 05:54:27 INFO - 'sessionrestore_no_auto_restore', 05:54:27 INFO - 'tabpaint']}, 05:54:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:54:27 INFO - 'tests': ['tsvgx', 05:54:27 INFO - 'tsvgr_opacity', 05:54:27 INFO - 'tart', 05:54:27 INFO - 'tscrollx', 05:54:27 INFO - 'cart']}, 05:54:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:54:27 INFO - 'tsvgr_opacity', 05:54:27 INFO - 'tart', 05:54:27 INFO - 'tscrollx', 05:54:27 INFO - 'cart']}, 05:54:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:27 INFO - 'talos_options': ['--disable-e10s'], 05:54:27 INFO - 'tests': ['tp5o']}, 05:54:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:27 INFO - 'tests': ['tp5o']}, 05:54:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:27 INFO - 'talos_options': ['--disable-e10s', 05:54:27 INFO - '--xperf_path', 05:54:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:27 INFO - 'tests': ['tp5n']}, 05:54:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:54:27 INFO - 'talos_options': ['--xperf_path', 05:54:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:54:27 INFO - 'tests': ['tp5n']}}, 05:54:27 INFO - 'talos.zip': {'path': '', 05:54:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:54:27 INFO - Running post-action listener: _resource_record_post_action 05:54:27 INFO - [mozharness: 2016-09-23 12:54:27.463726Z] Finished populate-webroot step (success) 05:54:27 INFO - [mozharness: 2016-09-23 12:54:27.463814Z] Running create-virtualenv step. 05:54:27 INFO - Running pre-action listener: _resource_record_pre_action 05:54:27 INFO - Running main action method: create_virtualenv 05:54:27 INFO - Creating virtualenv /builds/slave/test/build/venv 05:54:27 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 05:54:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:54:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:54:27 INFO - Using real prefix '/usr' 05:54:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:54:28 INFO - Installing distribute.............................................................................................................................................................................................done. 05:54:30 INFO - Installing pip.................done. 05:54:30 INFO - Return code: 0 05:54:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:54:30 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')]} 05:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:30 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')]} 05:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:30 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 0x7f5a0734ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7930>, '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 0x25c8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c8cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', '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 05:54:30 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 05:54:30 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 05:54:30 INFO - Using env: {'DISPLAY': ':0', 05:54:30 INFO - 'HOME': '/home/cltbld', 05:54:30 INFO - 'LANG': 'en_US.UTF-8', 05:54:30 INFO - 'LANGUAGE': 'en_US:en', 05:54:30 INFO - 'LOGNAME': 'cltbld', 05:54:30 INFO - 'MAIL': '/var/mail/cltbld', 05:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:30 INFO - 'MOZ_NO_REMOTE': '1', 05:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:30 INFO - 'NO_EM_RESTART': '1', 05:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:30 INFO - 'PWD': '/builds/slave/test', 05:54:30 INFO - 'SHELL': '/bin/bash', 05:54:30 INFO - 'SHLVL': '1', 05:54:30 INFO - 'TERM': 'linux', 05:54:30 INFO - 'TMOUT': '86400', 05:54:30 INFO - 'USER': 'cltbld', 05:54:30 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', 05:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:30 INFO - '_': '/tools/buildbot/bin/python'} 05:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:30 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 05:54:30 INFO - Cleaning up... 05:54:30 INFO - Return code: 0 05:54:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:54:30 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')]} 05:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:30 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')]} 05:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:30 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 0x7f5a0734ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7930>, '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 0x25c8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c8cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', '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 05:54:30 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 05:54:30 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 05:54:30 INFO - Using env: {'DISPLAY': ':0', 05:54:30 INFO - 'HOME': '/home/cltbld', 05:54:30 INFO - 'LANG': 'en_US.UTF-8', 05:54:30 INFO - 'LANGUAGE': 'en_US:en', 05:54:30 INFO - 'LOGNAME': 'cltbld', 05:54:30 INFO - 'MAIL': '/var/mail/cltbld', 05:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:30 INFO - 'MOZ_NO_REMOTE': '1', 05:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:30 INFO - 'NO_EM_RESTART': '1', 05:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:30 INFO - 'PWD': '/builds/slave/test', 05:54:30 INFO - 'SHELL': '/bin/bash', 05:54:30 INFO - 'SHLVL': '1', 05:54:30 INFO - 'TERM': 'linux', 05:54:30 INFO - 'TMOUT': '86400', 05:54:30 INFO - 'USER': 'cltbld', 05:54:30 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', 05:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:30 INFO - '_': '/tools/buildbot/bin/python'} 05:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:30 INFO - Downloading/unpacking psutil>=3.1.1 05:54:30 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 05:54:30 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 05:54:30 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 05:54:30 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 05:54:30 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 05:54:30 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 05:54:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:54:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:32 INFO - Installing collected packages: psutil 05:54:32 INFO - Running setup.py install for psutil 05:54:32 INFO - building 'psutil._psutil_linux' extension 05:54:32 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 05:54:32 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 05:54:32 INFO - building 'psutil._psutil_posix' extension 05:54:32 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 05:54:32 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 05:54:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:54:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:54:32 INFO - Successfully installed psutil 05:54:32 INFO - Cleaning up... 05:54:33 INFO - Return code: 0 05:54:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:54:33 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')]} 05:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:33 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')]} 05:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:33 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 0x7f5a0734ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7930>, '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 0x25c8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c8cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', '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 05:54:33 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 05:54:33 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 05:54:33 INFO - Using env: {'DISPLAY': ':0', 05:54:33 INFO - 'HOME': '/home/cltbld', 05:54:33 INFO - 'LANG': 'en_US.UTF-8', 05:54:33 INFO - 'LANGUAGE': 'en_US:en', 05:54:33 INFO - 'LOGNAME': 'cltbld', 05:54:33 INFO - 'MAIL': '/var/mail/cltbld', 05:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:33 INFO - 'MOZ_NO_REMOTE': '1', 05:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:33 INFO - 'NO_EM_RESTART': '1', 05:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:33 INFO - 'PWD': '/builds/slave/test', 05:54:33 INFO - 'SHELL': '/bin/bash', 05:54:33 INFO - 'SHLVL': '1', 05:54:33 INFO - 'TERM': 'linux', 05:54:33 INFO - 'TMOUT': '86400', 05:54:33 INFO - 'USER': 'cltbld', 05:54:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', 05:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:33 INFO - '_': '/tools/buildbot/bin/python'} 05:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:54:33 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 05:54:33 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 05:54:33 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 05:54:33 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 05:54:33 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 05:54:33 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 05:54:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:54:35 INFO - Installing collected packages: mozsystemmonitor 05:54:35 INFO - Running setup.py install for mozsystemmonitor 05:54:35 INFO - Successfully installed mozsystemmonitor 05:54:35 INFO - Cleaning up... 05:54:35 INFO - Return code: 0 05:54:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:54: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')]} 05:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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')]} 05:54:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5a0734ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7930>, '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 0x25c8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c8cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', '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 05:54: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==2.5.1'] in /builds/slave/test/build 05:54: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==2.5.1 05:54:35 INFO - Using env: {'DISPLAY': ':0', 05:54:35 INFO - 'HOME': '/home/cltbld', 05:54:35 INFO - 'LANG': 'en_US.UTF-8', 05:54:35 INFO - 'LANGUAGE': 'en_US:en', 05:54:35 INFO - 'LOGNAME': 'cltbld', 05:54:35 INFO - 'MAIL': '/var/mail/cltbld', 05:54:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:35 INFO - 'MOZ_NO_REMOTE': '1', 05:54:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:35 INFO - 'NO_EM_RESTART': '1', 05:54:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:35 INFO - 'PWD': '/builds/slave/test', 05:54:35 INFO - 'SHELL': '/bin/bash', 05:54:35 INFO - 'SHLVL': '1', 05:54:35 INFO - 'TERM': 'linux', 05:54:35 INFO - 'TMOUT': '86400', 05:54:35 INFO - 'USER': 'cltbld', 05:54:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', 05:54:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:35 INFO - '_': '/tools/buildbot/bin/python'} 05:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:35 INFO - Downloading/unpacking jsonschema==2.5.1 05:54:35 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 05:54:35 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 05:54:35 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 05:54:35 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 05:54:35 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 05:54:35 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 05:54:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:54:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:54:37 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 05:54:37 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 05:54:37 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 05:54:37 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 05:54:37 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 05:54:37 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 05:54:37 INFO - Downloading functools32-3.2.3-2.tar.gz 05:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:54:37 INFO - warning: no files found matching '*.txt' 05:54:37 INFO - no previously-included directories found matching 'build' 05:54:37 INFO - no previously-included directories found matching 'dist' 05:54:37 INFO - no previously-included directories found matching '.git*' 05:54:37 INFO - Installing collected packages: jsonschema, functools32 05:54:37 INFO - Running setup.py install for functools32 05:54:37 INFO - warning: no files found matching '*.txt' 05:54:37 INFO - no previously-included directories found matching 'build' 05:54:37 INFO - no previously-included directories found matching 'dist' 05:54:37 INFO - no previously-included directories found matching '.git*' 05:54:37 INFO - Successfully installed jsonschema functools32 05:54:37 INFO - Cleaning up... 05:54:37 INFO - Return code: 0 05:54:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:54:37 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')]} 05:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:37 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')]} 05:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:37 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 0x7f5a0734ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7930>, '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 0x25c8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c8cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', '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 05:54:37 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 05:54:37 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 05:54:37 INFO - Using env: {'DISPLAY': ':0', 05:54:37 INFO - 'HOME': '/home/cltbld', 05:54:37 INFO - 'LANG': 'en_US.UTF-8', 05:54:37 INFO - 'LANGUAGE': 'en_US:en', 05:54:37 INFO - 'LOGNAME': 'cltbld', 05:54:37 INFO - 'MAIL': '/var/mail/cltbld', 05:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:37 INFO - 'MOZ_NO_REMOTE': '1', 05:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:37 INFO - 'NO_EM_RESTART': '1', 05:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:37 INFO - 'PWD': '/builds/slave/test', 05:54:37 INFO - 'SHELL': '/bin/bash', 05:54:37 INFO - 'SHLVL': '1', 05:54:37 INFO - 'TERM': 'linux', 05:54:37 INFO - 'TMOUT': '86400', 05:54:37 INFO - 'USER': 'cltbld', 05:54:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', 05:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:37 INFO - '_': '/tools/buildbot/bin/python'} 05:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:54:38 INFO - Cleaning up... 05:54:38 INFO - Return code: 0 05:54:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:54:38 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')]} 05:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:38 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')]} 05:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:38 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 0x7f5a0734ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7930>, '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 0x25c8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c8cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', '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 05:54:38 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 05:54:38 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 05:54:38 INFO - Using env: {'DISPLAY': ':0', 05:54:38 INFO - 'HOME': '/home/cltbld', 05:54:38 INFO - 'LANG': 'en_US.UTF-8', 05:54:38 INFO - 'LANGUAGE': 'en_US:en', 05:54:38 INFO - 'LOGNAME': 'cltbld', 05:54:38 INFO - 'MAIL': '/var/mail/cltbld', 05:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:38 INFO - 'MOZ_NO_REMOTE': '1', 05:54:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:38 INFO - 'NO_EM_RESTART': '1', 05:54:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:38 INFO - 'PWD': '/builds/slave/test', 05:54:38 INFO - 'SHELL': '/bin/bash', 05:54:38 INFO - 'SHLVL': '1', 05:54:38 INFO - 'TERM': 'linux', 05:54:38 INFO - 'TMOUT': '86400', 05:54:38 INFO - 'USER': 'cltbld', 05:54:38 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', 05:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:38 INFO - '_': '/tools/buildbot/bin/python'} 05:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:38 INFO - Downloading/unpacking blobuploader==1.2.4 05:54:38 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 05:54:38 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 05:54:38 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 05:54:38 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 05:54:38 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 05:54:38 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 05:54:40 INFO - Downloading blobuploader-1.2.4.tar.gz 05:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:54:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:54:40 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 05:54:40 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 05:54:40 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 05:54:40 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 05:54:40 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 05:54:40 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 05:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:54:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:54:40 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 05:54:40 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 05:54:40 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 05:54:40 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 05:54:40 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 05:54:40 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 05:54:40 INFO - Downloading docopt-0.6.1.tar.gz 05:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:54:41 INFO - Installing collected packages: blobuploader, requests, docopt 05:54:41 INFO - Running setup.py install for blobuploader 05:54:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:54:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:54:41 INFO - Running setup.py install for requests 05:54:41 INFO - Running setup.py install for docopt 05:54:41 INFO - Successfully installed blobuploader requests docopt 05:54:41 INFO - Cleaning up... 05:54:41 INFO - Return code: 0 05:54:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:41 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')]} 05:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:41 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')]} 05:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:41 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 0x7f5a0734ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7930>, '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 0x25c8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c8cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', '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 05:54:41 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 05:54:41 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 05:54:41 INFO - Using env: {'DISPLAY': ':0', 05:54:41 INFO - 'HOME': '/home/cltbld', 05:54:41 INFO - 'LANG': 'en_US.UTF-8', 05:54:41 INFO - 'LANGUAGE': 'en_US:en', 05:54:41 INFO - 'LOGNAME': 'cltbld', 05:54:41 INFO - 'MAIL': '/var/mail/cltbld', 05:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:41 INFO - 'MOZ_NO_REMOTE': '1', 05:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:41 INFO - 'NO_EM_RESTART': '1', 05:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:41 INFO - 'PWD': '/builds/slave/test', 05:54:41 INFO - 'SHELL': '/bin/bash', 05:54:41 INFO - 'SHLVL': '1', 05:54:41 INFO - 'TERM': 'linux', 05:54:41 INFO - 'TMOUT': '86400', 05:54:41 INFO - 'USER': 'cltbld', 05:54:41 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', 05:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:41 INFO - '_': '/tools/buildbot/bin/python'} 05:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:41 INFO - Running setup.py (path:/tmp/pip-y4hWyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:41 INFO - Running setup.py (path:/tmp/pip-Cbx9hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:41 INFO - Running setup.py (path:/tmp/pip-p1h0cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:42 INFO - Running setup.py (path:/tmp/pip-VQcrpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:42 INFO - Running setup.py (path:/tmp/pip-LnDSEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:42 INFO - Running setup.py (path:/tmp/pip-UYbvup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:42 INFO - Running setup.py (path:/tmp/pip-i2PjfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:42 INFO - Running setup.py (path:/tmp/pip-vQaHqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:42 INFO - Running setup.py (path:/tmp/pip-0mHy8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:42 INFO - Running setup.py (path:/tmp/pip-Sv1ssO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:42 INFO - Running setup.py (path:/tmp/pip-XYny7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:42 INFO - Running setup.py (path:/tmp/pip-1_QuPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:42 INFO - Running setup.py (path:/tmp/pip-zdrb3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:42 INFO - Running setup.py (path:/tmp/pip-VgbG3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:42 INFO - Running setup.py (path:/tmp/pip-swwRF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:42 INFO - Running setup.py (path:/tmp/pip-45drhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:42 INFO - Running setup.py (path:/tmp/pip-lkjsAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:54:43 INFO - Running setup.py install for manifestparser 05:54:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Running setup.py install for mozcrash 05:54:43 INFO - Running setup.py install for mozdebug 05:54:43 INFO - Running setup.py install for mozdevice 05:54:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Running setup.py install for mozfile 05:54:43 INFO - Running setup.py install for mozhttpd 05:54:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Running setup.py install for mozinfo 05:54:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Running setup.py install for mozInstall 05:54:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:54:43 INFO - Running setup.py install for mozleak 05:54:43 INFO - Running setup.py install for mozlog 05:54:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:54:44 INFO - Running setup.py install for moznetwork 05:54:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:54:44 INFO - Running setup.py install for mozprocess 05:54:44 INFO - Running setup.py install for mozprofile 05:54:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:54:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:54:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:54:44 INFO - Running setup.py install for mozrunner 05:54:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:54:44 INFO - Running setup.py install for mozscreenshot 05:54:44 INFO - Running setup.py install for moztest 05:54:44 INFO - Running setup.py install for mozversion 05:54:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:54:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:54:44 INFO - Cleaning up... 05:54:44 INFO - Return code: 0 05:54:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:44 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')]} 05:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:44 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')]} 05:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:44 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 0x7f5a0734ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7930>, '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 0x25c8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c8cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', '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 05:54:44 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 05:54:44 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 05:54:44 INFO - Using env: {'DISPLAY': ':0', 05:54:44 INFO - 'HOME': '/home/cltbld', 05:54:44 INFO - 'LANG': 'en_US.UTF-8', 05:54:44 INFO - 'LANGUAGE': 'en_US:en', 05:54:44 INFO - 'LOGNAME': 'cltbld', 05:54:44 INFO - 'MAIL': '/var/mail/cltbld', 05:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:44 INFO - 'MOZ_NO_REMOTE': '1', 05:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:44 INFO - 'NO_EM_RESTART': '1', 05:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:44 INFO - 'PWD': '/builds/slave/test', 05:54:44 INFO - 'SHELL': '/bin/bash', 05:54:44 INFO - 'SHLVL': '1', 05:54:44 INFO - 'TERM': 'linux', 05:54:44 INFO - 'TMOUT': '86400', 05:54:44 INFO - 'USER': 'cltbld', 05:54:44 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', 05:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:44 INFO - '_': '/tools/buildbot/bin/python'} 05:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:54:45 INFO - Running setup.py (path:/tmp/pip-WfDUJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:54:45 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)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:54:45 INFO - Running setup.py (path:/tmp/pip-eFy0aE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:54:45 INFO - Running setup.py (path:/tmp/pip-ZeXvWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:54:45 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)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:54:45 INFO - Running setup.py (path:/tmp/pip-5oQlpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:54:45 INFO - Running setup.py (path:/tmp/pip-OKbGi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:54:45 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)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:54:45 INFO - Running setup.py (path:/tmp/pip-6K5BxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:54:45 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)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:54:45 INFO - Running setup.py (path:/tmp/pip-foC6Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:54:45 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)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:54:45 INFO - Running setup.py (path:/tmp/pip-cVg9zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:54:45 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)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:54:45 INFO - Running setup.py (path:/tmp/pip-a55YgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:54:45 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)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:54:45 INFO - Running setup.py (path:/tmp/pip-XxJyw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:54:45 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)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:54:45 INFO - Running setup.py (path:/tmp/pip-lNo0L7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:54:45 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)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:54:45 INFO - Running setup.py (path:/tmp/pip-dlHOPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:54:45 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)) 05:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:54:45 INFO - Running setup.py (path:/tmp/pip-sDzcSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:54:46 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)) 05:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:54:46 INFO - Running setup.py (path:/tmp/pip-g86aGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 05:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:46 INFO - Running setup.py (path:/tmp/pip-OyhxDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:54:46 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)) 05:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:54:46 INFO - Running setup.py (path:/tmp/pip-5PfvM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:54:46 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)) 05:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:54:46 INFO - Running setup.py (path:/tmp/pip-tCswqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:54:46 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)) 05:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:54:46 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)) 05:54:46 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:46 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:54:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:54:46 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 05:54:46 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 05:54:46 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 05:54:46 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 05:54:46 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 05:54:46 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 05:54:48 INFO - Downloading blessings-1.6.tar.gz 05:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:54:48 INFO - Installing collected packages: blessings 05:54:48 INFO - Running setup.py install for blessings 05:54:48 INFO - Successfully installed blessings 05:54:48 INFO - Cleaning up... 05:54:48 INFO - Return code: 0 05:54:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:48 INFO - Reading from file tmpfile_stdout 05:54:48 INFO - Current package versions: 05:54:48 INFO - argparse == 1.2.1 05:54:48 INFO - blessings == 1.6 05:54:48 INFO - blobuploader == 1.2.4 05:54:48 INFO - docopt == 0.6.1 05:54:48 INFO - functools32 == 3.2.3-2 05:54:48 INFO - jsonschema == 2.5.1 05:54:48 INFO - manifestparser == 1.1 05:54:48 INFO - mozInstall == 1.12 05:54:48 INFO - mozcrash == 0.17 05:54:48 INFO - mozdebug == 0.1 05:54:48 INFO - mozdevice == 0.48 05:54:48 INFO - mozfile == 1.2 05:54:48 INFO - mozhttpd == 0.7 05:54:48 INFO - mozinfo == 0.9 05:54:48 INFO - mozleak == 0.1 05:54:48 INFO - mozlog == 3.4 05:54:48 INFO - moznetwork == 0.27 05:54:48 INFO - mozprocess == 0.23 05:54:48 INFO - mozprofile == 0.28 05:54:48 INFO - mozrunner == 6.12 05:54:48 INFO - mozscreenshot == 0.1 05:54:48 INFO - mozsystemmonitor == 0.3 05:54:48 INFO - moztest == 0.7 05:54:48 INFO - mozversion == 1.4 05:54:48 INFO - psutil == 3.1.1 05:54:48 INFO - requests == 1.2.3 05:54:48 INFO - wsgiref == 0.1.2 05:54:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:54:48 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')]} 05:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 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')]} 05:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 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 0x7f5a0734ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7930>, '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 0x25c8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c8cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', '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 05:54:48 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 05:54:48 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 05:54:48 INFO - Using env: {'DISPLAY': ':0', 05:54:48 INFO - 'HOME': '/home/cltbld', 05:54:48 INFO - 'LANG': 'en_US.UTF-8', 05:54:48 INFO - 'LANGUAGE': 'en_US:en', 05:54:48 INFO - 'LOGNAME': 'cltbld', 05:54:48 INFO - 'MAIL': '/var/mail/cltbld', 05:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:48 INFO - 'MOZ_NO_REMOTE': '1', 05:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:48 INFO - 'NO_EM_RESTART': '1', 05:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:48 INFO - 'PWD': '/builds/slave/test', 05:54:48 INFO - 'SHELL': '/bin/bash', 05:54:48 INFO - 'SHLVL': '1', 05:54:48 INFO - 'TERM': 'linux', 05:54:48 INFO - 'TMOUT': '86400', 05:54:48 INFO - 'USER': 'cltbld', 05:54:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', 05:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:48 INFO - '_': '/tools/buildbot/bin/python'} 05:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:48 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)) 05:54:48 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)) 05:54:48 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)) 05:54:48 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)) 05:54:48 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)) 05:54:48 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)) 05:54:48 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)) 05:54:48 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)) 05:54:48 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)) 05:54:48 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)) 05:54:48 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)) 05:54:48 INFO - Cleaning up... 05:54:48 INFO - Return code: 0 05:54:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:54:48 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')]} 05:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 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')]} 05:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:54:48 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 0x7f5a0734ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25ca790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c7930>, '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 0x25c8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c8cc0>, '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': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', '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 05:54:48 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 05:54:48 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 05:54:48 INFO - Using env: {'DISPLAY': ':0', 05:54:48 INFO - 'HOME': '/home/cltbld', 05:54:48 INFO - 'LANG': 'en_US.UTF-8', 05:54:48 INFO - 'LANGUAGE': 'en_US:en', 05:54:48 INFO - 'LOGNAME': 'cltbld', 05:54:48 INFO - 'MAIL': '/var/mail/cltbld', 05:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:48 INFO - 'MOZ_NO_REMOTE': '1', 05:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:48 INFO - 'NO_EM_RESTART': '1', 05:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:48 INFO - 'PWD': '/builds/slave/test', 05:54:48 INFO - 'SHELL': '/bin/bash', 05:54:48 INFO - 'SHLVL': '1', 05:54:48 INFO - 'TERM': 'linux', 05:54:48 INFO - 'TMOUT': '86400', 05:54:48 INFO - 'USER': 'cltbld', 05:54:48 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', 05:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:48 INFO - '_': '/tools/buildbot/bin/python'} 05:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:54:49 INFO - Cleaning up... 05:54:49 INFO - Return code: 0 05:54:49 INFO - Running post-action listener: _resource_record_post_action 05:54:49 INFO - Running post-action listener: _start_resource_monitoring 05:54:49 INFO - Starting resource monitoring. 05:54:49 INFO - [mozharness: 2016-09-23 12:54:49.155713Z] Finished create-virtualenv step (success) 05:54:49 INFO - [mozharness: 2016-09-23 12:54:49.156221Z] Running install step. 05:54:49 INFO - Running pre-action listener: _resource_record_pre_action 05:54:49 INFO - Running main action method: install 05:54:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:54:49 INFO - Reading from file tmpfile_stdout 05:54:49 INFO - Detecting whether we're running mozinstall >=1.0... 05:54:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:54:49 INFO - Reading from file tmpfile_stdout 05:54:49 INFO - Output received: 05:54:49 INFO - Usage: mozinstall [options] installer 05:54:49 INFO - Options: 05:54:49 INFO - -h, --help show this help message and exit 05:54:49 INFO - -d DEST, --destination=DEST 05:54:49 INFO - Directory to install application into. [default: 05:54:49 INFO - "/builds/slave/test"] 05:54:49 INFO - --app=APP Application being installed. [default: firefox] 05:54:49 INFO - mkdir: /builds/slave/test/build/application 05:54:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:54:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:55:06 INFO - Reading from file tmpfile_stdout 05:55:06 INFO - Output received: 05:55:06 INFO - /builds/slave/test/build/application/firefox/firefox 05:55:06 INFO - Running post-action listener: _resource_record_post_action 05:55:06 INFO - [mozharness: 2016-09-23 12:55:06.960199Z] Finished install step (success) 05:55:06 INFO - [mozharness: 2016-09-23 12:55:06.960534Z] Running run-tests step. 05:55:06 INFO - Running pre-action listener: _resource_record_pre_action 05:55:06 INFO - Running main action method: run_tests 05:55:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:55:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:55:06 INFO - Python 2.7.3 05:55:06 INFO - Return code: 0 05:55:06 INFO - grabbing minidump binary from tooltool 05:55:06 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')]} 05:55:06 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 0x25c7930>, '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 0x25c8830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25c8cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:55:06 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 05:55:06 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 05:55:06 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 05:55:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:55:07 INFO - Return code: 0 05:55:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:55:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:55:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:55:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:55:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:55:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 05:55:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 05:55:07 INFO - Using env: {'DISPLAY': ':0', 05:55:07 INFO - 'HOME': '/home/cltbld', 05:55:07 INFO - 'LANG': 'en_US.UTF-8', 05:55:07 INFO - 'LANGUAGE': 'en_US:en', 05:55:07 INFO - 'LOGNAME': 'cltbld', 05:55:07 INFO - 'MAIL': '/var/mail/cltbld', 05:55:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:55:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:55:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:55:07 INFO - 'MOZ_NO_REMOTE': '1', 05:55:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:55:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:55:07 INFO - 'NO_EM_RESTART': '1', 05:55:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:55:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:55:07 INFO - 'PWD': '/builds/slave/test', 05:55:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:55:07 INFO - 'SHELL': '/bin/bash', 05:55:07 INFO - 'SHLVL': '1', 05:55:07 INFO - 'TERM': 'linux', 05:55:07 INFO - 'TMOUT': '86400', 05:55:07 INFO - 'USER': 'cltbld', 05:55:07 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720', 05:55:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:55:07 INFO - '_': '/tools/buildbot/bin/python'} 05:55:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 05:55:07 INFO - mozversion application_buildid: 20160923030450 05:55:07 INFO - mozversion application_changeset: 052d4d77cbcae9d168754a62e6f71fd9946743b0 05:55:07 INFO - mozversion application_display_name: Nightly 05:55:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:55:07 INFO - mozversion application_name: Firefox 05:55:07 INFO - mozversion application_remotingname: firefox 05:55:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:55:07 INFO - mozversion application_vendor: Mozilla 05:55:07 INFO - mozversion application_version: 52.0a1 05:55:07 INFO - mozversion platform_buildid: 20160923030450 05:55:07 INFO - mozversion platform_changeset: 052d4d77cbcae9d168754a62e6f71fd9946743b0 05:55:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:55:07 INFO - mozversion platform_version: 52.0a1 05:55:07 INFO - using testdate: 1474635307 05:55:07 INFO - actual date: 1474635307 05:55:07 INFO - starting webserver on 'localhost:33199' 05:55:07 INFO - SUITE-START | Running 2 tests 05:55:07 INFO - TEST-START | dromaeo_css 05:55:07 INFO - operating with platform_type : linux_ 05:55:07 INFO - Initialising browser for dromaeo_css test... 05:55:07 INFO - TEST-INFO | started process 16710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRrGmNJ/profile http://localhost:33199/getInfo.html) 05:55:11 INFO - PROCESS | 16710 | __metrics Screen width/height:1600/1200 05:55:11 INFO - PROCESS | 16710 | colorDepth:24 05:55:11 INFO - PROCESS | 16710 | Browser inner width/height: 1024/697 05:55:11 INFO - PROCESS | 16710 | __metrics 05:55:12 INFO - PROCESS | 16710 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:55:12 INFO - PROCESS | 16710 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:55:12 INFO - PROCESS | 16710 | console.error: PushService: 05:55:12 INFO - PROCESS | 16710 | stateChangeProcessEnqueue: Error transitioning state 05:55:12 INFO - PROCESS | 16710 | UnknownError 05:55:13 INFO - TEST-INFO | 16710: exit 0 05:55:13 INFO - Browser initialized. 05:55:13 INFO - Running cycle 1/1 for dromaeo_css test... 05:55:13 INFO - TEST-INFO | started process 16794 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRrGmNJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:25 INFO - PROCESS | 16794 | RSS: Main: 173436928 05:55:25 INFO - PROCESS | 16794 | 05:56:17 INFO - PROCESS | 16794 | 1474635377317 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] 05:58:26 INFO - PROCESS | 16794 | Cycle 1(1): loaded http://localhost:33199/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33199/tests/dromaeo/cssquery-ext.html) 05:58:28 INFO - PROCESS | 16794 | RSS: Main: 329146368 05:58:28 INFO - PROCESS | 16794 | 06:01:30 INFO - PROCESS | 16794 | Cycle 1(1): loaded http://localhost:33199/tests/dromaeo/cssquery-ext.html (next: http://localhost:33199/tests/dromaeo/cssquery-jquery.html) 06:01:31 INFO - PROCESS | 16794 | RSS: Main: 278228992 06:01:31 INFO - PROCESS | 16794 | 06:04:33 INFO - PROCESS | 16794 | Cycle 1(1): loaded http://localhost:33199/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33199/tests/dromaeo/cssquery-mootools.html) 06:04:34 INFO - PROCESS | 16794 | RSS: Main: 214564864 06:04:34 INFO - PROCESS | 16794 | 06:07:36 INFO - PROCESS | 16794 | Cycle 1(1): loaded http://localhost:33199/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33199/tests/dromaeo/cssquery-prototype.html) 06:07:36 INFO - PROCESS | 16794 | RSS: Main: 247721984 06:07:36 INFO - PROCESS | 16794 | 06:10:39 INFO - PROCESS | 16794 | Cycle 1(1): loaded http://localhost:33199/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33199/tests/dromaeo/cssquery-yui.html) 06:10:40 INFO - PROCESS | 16794 | RSS: Main: 213929984 06:10:40 INFO - PROCESS | 16794 | 06:13:43 INFO - PROCESS | 16794 | Cycle 1(1): loaded http://localhost:33199/tests/dromaeo/cssquery-yui.html (next: http://localhost:33199/tests/dromaeo/cssquery-dojo.html) 06:13:43 INFO - PROCESS | 16794 | RSS: Main: 307269632 06:13:43 INFO - PROCESS | 16794 | 06:13:43 INFO - PROCESS | 16794 | __start_tp_report 06:13:43 INFO - PROCESS | 16794 | _x_x_mozilla_page_load 06:13:43 INFO - PROCESS | 16794 | _x_x_mozilla_page_load_details 06:13:43 INFO - PROCESS | 16794 | |i|pagename|runs| 06:13:43 INFO - PROCESS | 16794 | |0;dojo.html;3022.319978004949;3025.4705426550363;3042.376312855865;3051.832149231792;3092.1032900458868;5160.870978225546;5206.297149884765;5268;5373.5701143908445;5386.8922621547545;5279.736013199335;5293.68237905725;5304.336957880265;5311.814086506973;5313.017091838013;4817.22924332107;4837.177679794443;4851.563359297663;4890.902181956377;4959.528844759742;4986.675866068712;5026.673266237683;5057.544820966113;5089.821856235032;5095.3376061112185;4954.232094025432;4969.080720066781;5029.899402011957;5033.169527028036;5038.017586570621;4875.780589873429;5004.474530174352;5010.899782004358;5041.1682072458;5084.110280700863;4881.682690625098;4902.093112774148;4929.457759646436;4971.975140124312;5003.4746351633285;5212.921806172911;5312.840614781563;5341.412444631087;5390.110631745757;5390.299261096072;5620.606557540974;5622.746976386032;5623.128415095667;5627.971860140714;5631.1271752878365;5685.175649530836;5752.252207213078;5760.654360738369;5761.827145185651;5776.913346299767;5238.240455133984;5265.86835329116;5271.235670827708;5311.28297679816;5377.946220537784;5735.541156707453;5751.424857514216;5761.164631128463;5761.39505351932;5824.534037277008;5535.308086489189;5547.33431988164;5547.750351234205;5550.944490555124;5554.50009499147;5586.13414920688;5614.354349249807;5635.549156067505;5639.971800140973;5726.141078838207;5650.0959846424375;5691.516221121168;5711.885762284731;5712.0860662293835;5713.657180569179;5726.0838265877255;5728.369879313273;5728.828135155952;5730.598858079894;5734.684592347461;4397.890052748707;4428.800703968329;4429.977850110793;4439.66702497314;4443.2224360736745;3928.43037759529;3950.170464202492;3960.2673505401594;3974.7813870237414;3995.0212198011673;5443.618946673695;5449.536789372948;5451.454854514517;5512.3660779010925;5532.2531458253425;5763.88472230553;5772.567057470623;5772.7113644317615;5776.277965254343;5783.739731712083;5251.159814429673;5279.287296214962;5284.365876094893;5446.128619420873;5452.427495112956;4958.876028099255;4993.875153121128;4994.625403094782;5016.072026675077;5081.517255860687;5866.120081987736;5874.148248504029;5875.794347197913;5884.941150588525;5960.433758792908;5618.353889302619;5758.481736643722;5759.712014399347;5766.077427611562;5794.739236734273;5808.099744539603;5901.29184497863;5923.170756094237;5941.67320797343;6042.607230530001;5685.51673107774;5692.5445964321925;5693.430656934273;5703.429657034263;5703.600747947604;5792.3049234090495;5795.39148389413;5807.767689292381;5809.50619197373;5809.50619197373;5481.0408178567795;5537.975474537224;5609.158626206102;5664.631798933056;5710.514606258348;5576.302962129734;5602.383737788921;5610.102383618601;5614.2701448811395;5666.943330566642;5577.051901176728;5587.972060139673;5588.189712491747;5599.832005039855;5605.691686957257;5460.126379779216;5514.393416724077;5636.5208957237455;5639.182318563868;5668.858278543069;5589.832305030855;5594.580406469449;5599.720013999202;5659.830205093689;5666.46168613981 06:13:43 INFO - PROCESS | 16794 | |1;ext.html;550.1857251268123;589.0281036290123;599.0863932502936;606.142308633284;620.1442010026163;30198.698013019864;30768.846155769217;41363.37954930678;42269;42270.15459690804;39549;43707.562924370744;43795;43809;43857.34213986793;8054.677812887478;8869.024407315206;9020.503872287021;9023.819523609523;9030;7908.762737117896;8271.421000529965;8280.089190189074;10410.531526081344;10688.09151222147;10870.72823179419;10950.288231264982;10952.123830093613;11010.119190464744;11022.118230541577;10815.242932994694;10842.891571084267;10852.891471085268;10878.782424351468;10885.564577416893;8024.919750802475;8070.515769053875;10289.176865850714;10630.309029913109;10641.57433702651;41499.377509337384;41717.37423938643;41737.791311043555;41766.79116604428;41825.79087104545;3394.6775056369606;3439.570053743282;3453.9481907771406;3635.4001589737663;3693.0028892199225;31100;31192.22019449532;31656;31720;31751.04746857598;4217.283061879488;4338.652907767371;4342.174986752539;4556.658250631216;4563.589276965089;332245;334391;335441;335453.32273338723;335531;55482;55811.44188558144;55823.76704931838;55858;55932.44067559273;57909.71045144747;58767.706161468916;58956.705216474504;59114.40885591089;59172.11241831376;14948.177850218124;15249.695006099815;15255.771163432557;15257.237138143271;15258.923705381623;11531.596394126165;11655;11678.357690327113;11681.76636467266;11684.94157529224;14138.858611413754;14409.207493587954;14411.92794036023;14614.123152610877;15545.611359716098;6220.968895155585;6362.236531616236;6369.426751592379;6455.289918109004;6546.116274302908;888.471359541072;1006.9647562335283;1019.9337043092323;1052.026875140492;1062.5431064642123;30708.85822835442;30795.846020769754;30885.536716949264;30887.536686949712;31247;1009.8737657792776;1021.7241344836852;1037.305005646219;1073.3291692692067;1085.3487907255583;15373.615659608375;16119.597010074607;16202.594935126715;16255.756163657554;16496.67006659884;483204;489276;489577;490741;493490.04159334337;47889;49227.26159107616;50157.74921125371;53851.19223211655;55230.72384638131;1302.2642207153117;1305.9804102938463;1344.7176093020576;1345.7173993461483;1362.2711849160848;29482.262943426587;31225.8438707805;31355.84322078375;31676.5248521277;32312.35375292528;47866.760666196446;48303.75848120737;48388.758056209495;48500;48596.514034860615;444371;454593;454946;668420;669470;26568.601470978338;26708.332291692863;26986.1904142876;27097.322566935985;27165.59251611267;43132;43654.56345436505;44606.3309050358;45207.773961129984;45263.77368113138;37221.627783721815;37850.810745947194;37989;38232;39515.40726889156;37979;38404.62335273008;38778.80610596929;38885.80557097196;39184.608153918096;36286.45570316395;36440.27119457649;37212;37496.62503374931;38090.61909380871;32933;34660.82669586636;35116.29767404689;35694.28611427705;35776.10559736027;25687.871560642077;25747;26210.606840897784;26368.8681556591;26640.467190656465 06:13:43 INFO - PROCESS | 16794 | |2;jquery.html;362.2700258978161;380.42555740831335;381.4621383848772;389.696037091069;397.58651002956924;14375.137491750502;18349.81650183498;19067.713984290247;19136.80863191371;20290.89854550725;17481.650366992653;18447.72328415075;18499.815001849976;18676.159572819222;18678.15948282327;5554.444555544444;5885.61743486672;5892.410758924095;5893.292804863422;5893.911591326134;4126.261823384456;4253.553376895427;5760.8271751847515;5826.15520749491;6462.159919210496;6515.38103880133;6535.771248006321;6540.771073012422;6543.1821022372205;6546.541742078057;6300.275468321133;6507.642079685639;6513.837154071139;6525.314841941623;6552.967235163794;5759.107338362561;5783.929972954975;5785.074388097884;5792.536597072266;5795.391483894173;22323.330300091024;22760.77239227603;22900.885495572584;23007.769922300897;23020.30939071814;2449.497852940143;2520.4877073755783;2683.6645419322585;2688.206978941217;2974.092901664991;14020.85979140216;14259.429622815074;14267.643308917257;14391.2084835334;14562.344694488667;1783.7413575031678;1880.0787614069145;1898.905054747257;1914.8372388347007;1979.712941623471;79283;80150;81786.59106704428;82640.58679706624;82961.3407731848;10140.087392134743;10205.489725513695;10511.316764410289;10534.315269507457;10947.50736216872;14693.118412895261;14710.117392956457;14711.632209194855;14729.705405892037;14735.92632036833;7032.8945065824055;7316.743913963092;7421.332080112816;7483.550986940692;7530.322270995636;7034.331738484836;7040.331168538981;7045.788626341116;7301.342879140902;7326.04761381017;6418.8716225675225;6449.290578036413;6509.804705858832;6513.804585862432;6539.901901471481;1778.1642627964836;1813.9435051937528;1830.8626852986079;1849.426677729881;1868.9813101869079;936.7049379445452;984.9458279794537;1026.7484466305802;1028.953697083618;1093.2565855218368;18856.15147318374;19588.70616940747;19665.311714089938;19753.40739777809;19992.60014799696;930.6463543853292;979.5787811241235;996.2080146283722;1002.6891663584312;1036.08824234673;10277.126444252322;11089.780124186333;11232.49453774582;11276.830847537294;11322.603708870314;447247;456516;456518;457698;461333;50007.49932506092;84652.15347846565;87074;87119;87183;973.4354074636693;1006.4615430744517;1017.4404077757204;1027.275770581738;1038.7974345002804;16651.916740416706;16687.666246674755;17393.217305221548;17662.381816636356;17993.73009404886;40784;40963;41659.37510937278;41754.582454176285;42584.148317032865;53464.198037030255;54469.72765136149;56744.432555675565;57078.14382784344;60951.69524152351;8395.412321137463;8849.115088491099;8884.511351875708;8891.088415990593;8930.776730581787;12487.375631218585;13337.933310333387;13372.866271337161;13452.645786987434;13498.865011350154;10948.890511094787;11167.609133680282;11706.414679266172;11750.118741094622;11759;11606;11686.123540734308;11723.179377443497;11984.612398664438;12016.399180041139;11904.58333958342;11996;12107.273563586214;12459.314737689514;12517.436715347649;8562.400631955703;8642.78393040179;8775.591730749871;8956.820863582821;9051.321150913576;10785.382192670848;11103.777924441627;11435.485403156712;11557.13321500874;11763.823542646696 06:13:43 INFO - PROCESS | 16794 | |3;mootools.html;1303.367866584707;1463.9194844283563;1504.8871334649903;1638.4265507072525;1789;7757.961210193948;8734.170253825892;8950.104989501055;8960.641574337018;9177.944536378302;8964.50695211763;9031.864522032174;9039.502827344493;9051.72844814655;9103.408278461895;2298.6666933294705;2317.582835089683;2318.988405057981;2324.790768830805;2326.6510023496444;2324.0239099578216;2324.732655744586;2372.063035101134;2378.4767351182713;2382.03527571333;2315.1781117703226;2319.7100362454694;2326.813854891613;2378.92863214103;2380.9166679166233;2284.383216531544;2305.700258966332;2317.1310758465575;2319.976800231993;2330.906763729449;2263.309690544383;2265.478939843845;2277.806386457153;2281.441046943493;2286.7598902115205;8913.732588022369;8962.86555701665;9020.458772473672;9045.231155351803;9153.54232288383;5193.8961220775755;5306.230596563515;5325.041492531343;5328.094223981893;5329.413764485942;3441.6558344165633;3474.617792042873;3518.4018716817945;3538.841306802848;3555.5911070227;1203.5366383942157;1206.1556910162922;1213.308414203904;1214.7934851075338;1221.4686611324103;12323.568675096418;12453;12477.563285284972;12519.186252893533;12522.74954500914;4157.605027522381;4376.365427013129;4444.911101778011;4469.150861336336;4559.361689363492;9844;9863.408195508293;9866.161376282953;9883.406995580288;9890.950545247228;5124.077666020077;5154.7164905929785;5158.561522270574;5163.225516172529;5164.147915593885;4174.7077704561;4292.935605965913;4675.625949923998;4754.548317909793;4774.21225497789;3550.431930891045;3704.3700771660383;3712.7215458840697;3752.4746535485056;3754.5682246541996;1140.321508702321;1145.3700464744356;1154.0536759857005;1159.9594014209463;1165.906727461801;842.2293601354814;915.6520522201521;940.9952950235205;941.764558860285;973.5035132082688;5931.13998470228;5980.940190598125;6078.270607527125;6301.369863013662;6392.744290228339;941.5904081724472;946.9289803264783;977.1205914676848;988.6935050134338;1010.434156872154;3979.880603581897;4102.979485102555;4118.45401407614;4126.154138401621;4181.954511372157;10771.246012779187;11077.556897724162;11138.554457821596;11152.386618735885;11189.384583847966;10991.06575941038;11057.06014988719;11118.722031949104;11134.554617815358;11142.554297828157;8166.959165204136;8173.100958894517;8216.424850260544;8249.876251856227;8254.257116859511;5589.916151257653;5633.492985631313;5775.711214439178;5823.82528524145;5939.218234529538;10290.485475726035;10295;10307.433091180057;10329.173666106542;10352.223583231438;9617.278704097082;10035.397876127456;10047.045530674573;10123.493825308853;10161.441120738431;7129.536580122275;7335.523190992569;7734.961325193338;7955.4828936118965;8081.070676872235;8464.322854171774;8787.472751634923;8799.428037177562;8800.867986980073;8810.823783524422;7698.191689872483;7708.845823083395;7722.961385193038;7893.289603935674;8161.836763264821;7836.490628109154;7887.881681774663;7903.1306556279915;7930.444868859356;8028.799280018046;7164.749233776793;7170.5647178888685;7257.637118144177;7261.818454538678;7264.055672762507;5113.488651135006;5175.353080864892;5189.065968125774;5207.687538747536;5366.731663416892;4999.550040496373;5066.417362003417;5124.385073791169;5180.860210753628;5347.946520534745 06:13:43 INFO - PROCESS | 16794 | |4;prototype.html;327.845912421162;336.6213010363341;337.84290305008165;342.6111363602314;345.93081383723256;5139.4346621871655;5240.292560504331;5292.470752924711;5332.733363331832;5342.545883599893;5057.939946332471;5149.249255253213;5191.247269145972;5233.502817232366;5238.5023422774875;4167.687423443239;4174.08170202555;4184.518780340261;4190.769507677077;4220.957790422102;3954.5254569451704;4042.615951484619;4159.334506478964;4185;4191.455110835587;4062.4312596236405;4065.715399922007;4072.7149099563044;4074;4082.122343696105;4071.145059537501;4073.918521629551;4107.301758701028;4121.732087414309;4123.814428350702;3640.1809592841664;3651.6165802590876;3653.1232504199065;3665;3673.8611030580605;5104.923426148611;5106.617003724736;5128.282040514331;5132.563732082777;5134.204198349262;4620.376249206348;4651.093036857814;4685.601723853477;4708.399144290957;4717.858464246044;5468.7539060742365;5471.534919531845;5481.260029895953;5503.670279480936;5505.256790333294;3756.812159392047;3932.5674175840636;3953.822078006468;3962.9498182981533;3978.2694527880462;5624.634398764068;5639.238702775114;5657.60396772222;5674.347450043216;5675.971620141873;4070.470838790938;4082.1835632873544;4100.2414553307735;4111.835526578903;4120.990357362465;4046.1705350403686;4074.246264441088;4114.814833332507;4122.474684366804;4161.271777438936;4619.514950930171;4674.859754207379;4675.392199014106;4675.57919787214;4688.929666055012;5493.697846618475;5498.670079795225;5507.476789704971;5536.4186760390385;5562.833115006556;1330.3281842669583;1359.6464919120901;1411.84469708332;1416.4546649539795;1420.3324437514352;904.6291020681489;919.5356345045843;925.7731855695398;940.6895724410928;943.4103685196752;4635.678831532997;4657.672563319437;4658.883527911829;4665.906681866344;4669.766511674471;4849.515048495122;4873.731944743002;4902.877428064256;4916.271469334553;4972.453030166679;4452.840372419374;4637.25803871379;4643.814247430132;4644.767761611906;4672.275797251432;2611.6865976082613;2627.9605805912925;2632.6182703507884;2634.0385759197757;2641.5773476243708;5045;5065.797368105234;5087.669301495391;5102.285680004802;5140.072472822691;4811.831585894477;4916.394311015168;5071.518205770446;5073.188289873677;5078.181609206852;5013.924791128136;5038.924416133761;5053.852112852023;5066.670666406671;5067;4916.385451818523;4934.3585333907795;4941.481144479922;4946.1591529439365;4949.97525012387;4625;4876.95123048765;4879.414470263591;4944.332515110558;4957.033378491304;5052.5705315048635;5052.823151189691;5082.440931497458;5106.66806657566;5122.359705036871;3690.9146332323226;3718.925621487609;3726;3773.52830896138;3779.640934111255;5019.799208031638;5036.118679231046;5046.949530504795;5068.746562671778;5511.338639363302;5553.972230138824;5560.4161563035295;5590.496855283044;5648.5763567731765;5661.094224923992;5570.6657600544095;5576.637518561281;5590.496855283044;5592.832215033555;5663.575231857545;5289.497497737709;5515.944840551543;5542.61201715876;5620.6393314807065;5631.493165615114;5530.198121272473;5580.888382232414;5582.246396736551;5596.468335508121;5611.551075913835;5502.504774570308;5552;5554.528234935577;5555.805546805843;5558.138488534284 06:13:43 INFO - PROCESS | 16794 | |5;yui.html;689.5793565924785;725.713343229424;735.8146305472744;795.9960200198998;842.2546046748628;16175.757363639541;17049.403270885523;17097.743533847002;17115.40096096637;17119.914400427995;14636.195009274512;14926.925365373158;15079;15149.091054536708;15174.393024279016;779.0223269796426;781.1914668318292;785.83104632504;786.3041208530434;787.3897729259841;652.6508318049845;660.4155322539563;767.2212704105337;775.170567492783;778.3889646627399;825.413956091173;833.2459124492314;836.067784420373;842.9452085614446;843.0726201178716;806.3267171911461;811.3387589114852;812.0417906869891;812.1472453923357;815.0789607743242;508.0905179728282;509.617786660005;592.7688201601379;592.9347771745105;595.6991719181785;14464.783028254584;14736.484223052248;14781.704365912728;15355.616109597238;15374.615634609112;14375.424983000667;14732.779008314883;15310.846891531053;15445.922770386076;15665.765013524806;11953.760924781456;11960.282383057045;12003.819942700778;12233.694157646041;12249.816252756216;3779.3764028935193;3854.2869569129803;3860.645006546005;4026.697997650188;4026.879193624196;82191.5890420544;82869.58565207195;84056;84332.57833710792;84849.57575212145;10813.945930270298;11109.44452777358;11220.943895280472;11235.213535052468;11531.654050378502;21681.783182167976;22466.32601021972;23519.294421167393;23578.646320305208;23624.527509449716;8294.631385821393;8304.916950830535;8417.158284171534;8529.44116764968;8695.695650652196;4667.883302917454;4727.267273572602;4729.172394830891;4824.107540105092;4835.709857408497;3441.552598162273;3551.751377403609;3553.6446355364255;3553.8400771965325;3557.4130268505924;591.7455494137477;598.0789584040529;606.3178923710825;612.087988896541;612.5650787940613;619.9987020961115;638.8530637953297;649.9350064993557;671.4785978650235;697.5500801982794;9014.774630634287;9378.5310734463;9470.431774093577;9626.855597166048;9922.751931201778;665.2017578905333;665.8668266346654;683.282553319013;699.762080892499;699.7935608995358;4569.634429245652;4668.416447944007;4781.11549363362;4787.49145625356;4800;113747;126040;128172;130812;132589;104713;107276.46361768141;108285.45857270663;108950;112056;90975.54512227396;93742.5312873445;96196.51901740587;96653.50197470436;99441;8680.479171249744;8955.641774328953;9060.411073280216;9094.181523662637;9095.317851161322;52582.73708631585;53096;53503.46496534985;55021.724891375285;55291.72354138204;45329.546704532535;46082;48612.75693621509;77869.61065194638;81407;10901.454927253764;11368.033717134136;11510.36692981894;11870.406479675808;11936.58221962227;13506.932465338003;14161.291935403395;14541.927290363481;15043.924780376028;15126.621834454227;13782.724345512834;14318.928405357907;14584.052036617586;14626.926865365605;15212.391504339703;14335.641608959859;14349.856501434851;14687.24193853292;14880.702385952436;15009.699806004037;13079.869201307865;13797.586072417844;13941.163530187816;13993.440262389391;14115.435382584581;10301.9484902575;10563.947180264357;11657.300561966309;11786.351750653796;11903.345316007702;9896.653617123366;10144.340617859816;11189.272697274977;11272.210945234083;11531.596394126165 06:13:43 INFO - PROCESS | 16794 | __end_tp_report 06:13:43 INFO - PROCESS | 16794 | __start_cc_report 06:13:43 INFO - PROCESS | 16794 | _x_x_mozilla_cycle_collect,1214 06:13:43 INFO - PROCESS | 16794 | __end_cc_report 06:13:43 INFO - PROCESS | 16794 | __startTimestamp1474636423607__endTimestamp 06:13:43 INFO - PROCESS | 16794 | 06:13:43 INFO - PROCESS | 16794 | ------- Summary: start ------- 06:13:43 INFO - PROCESS | 16794 | Number of tests: 6 06:13:43 INFO - PROCESS | 16794 | 06:13:43 INFO - PROCESS | 16794 | [#0] dojo.html Cycles:165 Average:5331.18 Median:5550.94 stddev:589.68 (10.6%) stddev-sans-first:562.99 06:13:43 INFO - PROCESS | 16794 | Values: 3022.3 3025.5 3042.4 3051.8 3092.1 5160.9 5206.3 5268.0 5373.6 5386.9 5279.7 5293.7 5304.3 5311.8 5313.0 4817.2 4837.2 4851.6 4890.9 4959.5 4986.7 5026.7 5057.5 5089.8 5095.3 4954.2 4969.1 5029.9 5033.2 5038.0 4875.8 5004.5 5010.9 5041.2 5084.1 4881.7 4902.1 4929.5 4972.0 5003.5 5212.9 5312.8 5341.4 5390.1 5390.3 5620.6 5622.7 5623.1 5628.0 5631.1 5685.2 5752.3 5760.7 5761.8 5776.9 5238.2 5265.9 5271.2 5311.3 5377.9 5735.5 5751.4 5761.2 5761.4 5824.5 5535.3 5547.3 5547.8 5550.9 5554.5 5586.1 5614.4 5635.5 5640.0 5726.1 5650.1 5691.5 5711.9 5712.1 5713.7 5726.1 5728.4 5728.8 5730.6 5734.7 4397.9 4428.8 4430.0 4439.7 4443.2 3928.4 3950.2 3960.3 3974.8 3995.0 5443.6 5449.5 5451.5 5512.4 5532.3 5763.9 5772.6 5772.7 5776.3 5783.7 5251.2 5279.3 5284.4 5446.1 5452.4 4958.9 4993.9 4994.6 5016.1 5081.5 5866.1 5874.1 5875.8 5884.9 5960.4 5618.4 5758.5 5759.7 5766.1 5794.7 5808.1 5901.3 5923.2 5941.7 6042.6 5685.5 5692.5 5693.4 5703.4 5703.6 5792.3 5795.4 5807.8 5809.5 5809.5 5481.0 5538.0 5609.2 5664.6 5710.5 5576.3 5602.4 5610.1 5614.3 5666.9 5577.1 5588.0 5588.2 5599.8 5605.7 5460.1 5514.4 5636.5 5639.2 5668.9 5589.8 5594.6 5599.7 5659.8 5666.5 06:13:43 INFO - PROCESS | 16794 | 06:13:43 INFO - PROCESS | 16794 | [#1] ext.html Cycles:180 Average:60091.39 Median:20037.84 stddev:124215.44 (619.9%) stddev-sans-first:124483.45 06:13:43 INFO - PROCESS | 16794 | Values: 550.2 589.0 599.1 606.1 620.1 30198.7 30768.8 41363.4 42269.0 42270.2 39549.0 43707.6 43795.0 43809.0 43857.3 8054.7 8869.0 9020.5 9023.8 9030.0 7908.8 8271.4 8280.1 10410.5 10688.1 10870.7 10950.3 10952.1 11010.1 11022.1 10815.2 10842.9 10852.9 10878.8 10885.6 8024.9 8070.5 10289.2 10630.3 10641.6 41499.4 41717.4 41737.8 41766.8 41825.8 3394.7 3439.6 3453.9 3635.4 3693.0 31100.0 31192.2 31656.0 31720.0 31751.0 4217.3 4338.7 4342.2 4556.7 4563.6 332245.0 334391.0 335441.0 335453.3 335531.0 55482.0 55811.4 55823.8 55858.0 55932.4 57909.7 58767.7 58956.7 59114.4 59172.1 14948.2 15249.7 15255.8 15257.2 15258.9 11531.6 11655.0 11678.4 11681.8 11684.9 14138.9 14409.2 14411.9 14614.1 15545.6 6221.0 6362.2 6369.4 6455.3 6546.1 888.5 1007.0 1019.9 1052.0 1062.5 30708.9 30795.8 30885.5 30887.5 31247.0 1009.9 1021.7 1037.3 1073.3 1085.3 15373.6 16119.6 16202.6 16255.8 16496.7 483204.0 489276.0 489577.0 490741.0 493490.0 47889.0 49227.3 50157.7 53851.2 55230.7 1302.3 1306.0 1344.7 1345.7 1362.3 29482.3 31225.8 31355.8 31676.5 32312.4 47866.8 48303.8 48388.8 48500.0 48596.5 444371.0 454593.0 454946.0 668420.0 669470.0 26568.6 26708.3 26986.2 27097.3 27165.6 43132.0 43654.6 44606.3 45207.8 45263.8 37221.6 37850.8 37989.0 38232.0 39515.4 37979.0 38404.6 38778.8 38885.8 39184.6 36286.5 36440.3 37212.0 37496.6 38090.6 32933.0 34660.8 35116.3 35694.3 35776.1 25687.9 25747.0 26210.6 26368.9 26640.5 06:13:43 INFO - PROCESS | 16794 | 06:13:43 INFO - PROCESS | 16794 | [#2] jquery.html Cycles:180 Average:27766.60 Median:2602.08 stddev:75092.08 (2885.9%) stddev-sans-first:75274.54 06:13:43 INFO - PROCESS | 16794 | Values: 362.3 380.4 381.5 389.7 397.6 14375.1 18349.8 19067.7 19136.8 20290.9 17481.7 18447.7 18499.8 18676.2 18678.2 5554.4 5885.6 5892.4 5893.3 5893.9 4126.3 4253.6 5760.8 5826.2 6462.2 6515.4 6535.8 6540.8 6543.2 6546.5 6300.3 6507.6 6513.8 6525.3 6553.0 5759.1 5783.9 5785.1 5792.5 5795.4 22323.3 22760.8 22900.9 23007.8 23020.3 2449.5 2520.5 2683.7 2688.2 2974.1 14020.9 14259.4 14267.6 14391.2 14562.3 1783.7 1880.1 1898.9 1914.8 1979.7 79283.0 80150.0 81786.6 82640.6 82961.3 10140.1 10205.5 10511.3 10534.3 10947.5 14693.1 14710.1 14711.6 14729.7 14735.9 7032.9 7316.7 7421.3 7483.6 7530.3 7034.3 7040.3 7045.8 7301.3 7326.0 6418.9 6449.3 6509.8 6513.8 6539.9 1778.2 1813.9 1830.9 1849.4 1869.0 936.7 984.9 1026.7 1029.0 1093.3 18856.2 19588.7 19665.3 19753.4 19992.6 930.6 979.6 996.2 1002.7 1036.1 10277.1 11089.8 11232.5 11276.8 11322.6 447247.0 456516.0 456518.0 457698.0 461333.0 50007.5 84652.2 87074.0 87119.0 87183.0 973.4 1006.5 1017.4 1027.3 1038.8 16651.9 16687.7 17393.2 17662.4 17993.7 40784.0 40963.0 41659.4 41754.6 42584.1 53464.2 54469.7 56744.4 57078.1 60951.7 8395.4 8849.1 8884.5 8891.1 8930.8 12487.4 13337.9 13372.9 13452.6 13498.9 10948.9 11167.6 11706.4 11750.1 11759.0 11606.0 11686.1 11723.2 11984.6 12016.4 11904.6 11996.0 12107.3 12459.3 12517.4 8562.4 8642.8 8775.6 8956.8 9051.3 10785.4 11103.8 11435.5 11557.1 11763.8 06:13:43 INFO - PROCESS | 16794 | 06:13:43 INFO - PROCESS | 16794 | [#3] mootools.html Cycles:180 Average:5818.77 Median:5032.98 stddev:3339.52 (66.4%) stddev-sans-first:3331.65 06:13:43 INFO - PROCESS | 16794 | Values: 1303.4 1463.9 1504.9 1638.4 1789.0 7758.0 8734.2 8950.1 8960.6 9177.9 8964.5 9031.9 9039.5 9051.7 9103.4 2298.7 2317.6 2319.0 2324.8 2326.7 2324.0 2324.7 2372.1 2378.5 2382.0 2315.2 2319.7 2326.8 2378.9 2380.9 2284.4 2305.7 2317.1 2320.0 2330.9 2263.3 2265.5 2277.8 2281.4 2286.8 8913.7 8962.9 9020.5 9045.2 9153.5 5193.9 5306.2 5325.0 5328.1 5329.4 3441.7 3474.6 3518.4 3538.8 3555.6 1203.5 1206.2 1213.3 1214.8 1221.5 12323.6 12453.0 12477.6 12519.2 12522.7 4157.6 4376.4 4444.9 4469.2 4559.4 9844.0 9863.4 9866.2 9883.4 9891.0 5124.1 5154.7 5158.6 5163.2 5164.1 4174.7 4292.9 4675.6 4754.5 4774.2 3550.4 3704.4 3712.7 3752.5 3754.6 1140.3 1145.4 1154.1 1160.0 1165.9 842.2 915.7 941.0 941.8 973.5 5931.1 5980.9 6078.3 6301.4 6392.7 941.6 946.9 977.1 988.7 1010.4 3979.9 4103.0 4118.5 4126.2 4182.0 10771.2 11077.6 11138.6 11152.4 11189.4 10991.1 11057.1 11118.7 11134.6 11142.6 8167.0 8173.1 8216.4 8249.9 8254.3 5589.9 5633.5 5775.7 5823.8 5939.2 10290.5 10295.0 10307.4 10329.2 10352.2 9617.3 10035.4 10047.0 10123.5 10161.4 7129.5 7335.5 7735.0 7955.5 8081.1 8464.3 8787.5 8799.4 8800.9 8810.8 7698.2 7708.8 7723.0 7893.3 8161.8 7836.5 7887.9 7903.1 7930.4 8028.8 7164.7 7170.6 7257.6 7261.8 7264.1 5113.5 5175.4 5189.1 5207.7 5366.7 4999.6 5066.4 5124.4 5180.9 5347.9 06:13:43 INFO - PROCESS | 16794 | 06:13:43 INFO - PROCESS | 16794 | [#4] prototype.html Cycles:180 Average:4444.07 Median:4937.92 stddev:1278.79 (25.9%) stddev-sans-first:1244.50 06:13:43 INFO - PROCESS | 16794 | Values: 327.8 336.6 337.8 342.6 345.9 5139.4 5240.3 5292.5 5332.7 5342.5 5057.9 5149.2 5191.2 5233.5 5238.5 4167.7 4174.1 4184.5 4190.8 4221.0 3954.5 4042.6 4159.3 4185.0 4191.5 4062.4 4065.7 4072.7 4074.0 4082.1 4071.1 4073.9 4107.3 4121.7 4123.8 3640.2 3651.6 3653.1 3665.0 3673.9 5104.9 5106.6 5128.3 5132.6 5134.2 4620.4 4651.1 4685.6 4708.4 4717.9 5468.8 5471.5 5481.3 5503.7 5505.3 3756.8 3932.6 3953.8 3962.9 3978.3 5624.6 5639.2 5657.6 5674.3 5676.0 4070.5 4082.2 4100.2 4111.8 4121.0 4046.2 4074.2 4114.8 4122.5 4161.3 4619.5 4674.9 4675.4 4675.6 4688.9 5493.7 5498.7 5507.5 5536.4 5562.8 1330.3 1359.6 1411.8 1416.5 1420.3 904.6 919.5 925.8 940.7 943.4 4635.7 4657.7 4658.9 4665.9 4669.8 4849.5 4873.7 4902.9 4916.3 4972.5 4452.8 4637.3 4643.8 4644.8 4672.3 2611.7 2628.0 2632.6 2634.0 2641.6 5045.0 5065.8 5087.7 5102.3 5140.1 4811.8 4916.4 5071.5 5073.2 5078.2 5013.9 5038.9 5053.9 5066.7 5067.0 4916.4 4934.4 4941.5 4946.2 4950.0 4625.0 4877.0 4879.4 4944.3 4957.0 5052.6 5052.8 5082.4 5106.7 5122.4 3690.9 3718.9 3726.0 3773.5 3779.6 5019.8 5036.1 5046.9 5068.7 5511.3 5554.0 5560.4 5590.5 5648.6 5661.1 5570.7 5576.6 5590.5 5592.8 5663.6 5289.5 5515.9 5542.6 5620.6 5631.5 5530.2 5580.9 5582.2 5596.5 5611.6 5502.5 5552.0 5554.5 5555.8 5558.1 06:13:43 INFO - PROCESS | 16794 | 06:13:43 INFO - PROCESS | 16794 | [#5] yui.html Cycles:180 Average:21576.99 Median:25325.82 stddev:32191.75 (127.1%) stddev-sans-first:32243.85 06:13:43 INFO - PROCESS | 16794 | Values: 689.6 725.7 735.8 796.0 842.3 16175.8 17049.4 17097.7 17115.4 17119.9 14636.2 14926.9 15079.0 15149.1 15174.4 779.0 781.2 785.8 786.3 787.4 652.7 660.4 767.2 775.2 778.4 825.4 833.2 836.1 842.9 843.1 806.3 811.3 812.0 812.1 815.1 508.1 509.6 592.8 592.9 595.7 14464.8 14736.5 14781.7 15355.6 15374.6 14375.4 14732.8 15310.8 15445.9 15665.8 11953.8 11960.3 12003.8 12233.7 12249.8 3779.4 3854.3 3860.6 4026.7 4026.9 82191.6 82869.6 84056.0 84332.6 84849.6 10813.9 11109.4 11220.9 11235.2 11531.7 21681.8 22466.3 23519.3 23578.6 23624.5 8294.6 8304.9 8417.2 8529.4 8695.7 4667.9 4727.3 4729.2 4824.1 4835.7 3441.6 3551.8 3553.6 3553.8 3557.4 591.7 598.1 606.3 612.1 612.6 620.0 638.9 649.9 671.5 697.6 9014.8 9378.5 9470.4 9626.9 9922.8 665.2 665.9 683.3 699.8 699.8 4569.6 4668.4 4781.1 4787.5 4800.0 113747.0 126040.0 128172.0 130812.0 132589.0 104713.0 107276.5 108285.5 108950.0 112056.0 90975.5 93742.5 96196.5 96653.5 99441.0 8680.5 8955.6 9060.4 9094.2 9095.3 52582.7 53096.0 53503.5 55021.7 55291.7 45329.5 46082.0 48612.8 77869.6 81407.0 10901.5 11368.0 11510.4 11870.4 11936.6 13506.9 14161.3 14541.9 15043.9 15126.6 13782.7 14318.9 14584.1 14626.9 15212.4 14335.6 14349.9 14687.2 14880.7 15009.7 13079.9 13797.6 13941.2 13993.4 14115.4 10301.9 10563.9 11657.3 11786.4 11903.3 9896.7 10144.3 11189.3 11272.2 11531.6 06:13:43 INFO - PROCESS | 16794 | -------- Summary: end -------- 06:13:43 INFO - PROCESS | 16794 | 06:13:44 INFO - TEST-INFO | 16794: exit 0 06:13:44 INFO - TEST-OK | dromaeo_css | took 1117337ms 06:13:44 INFO - TEST-START | kraken 06:13:44 INFO - operating with platform_type : linux_ 06:13:44 INFO - Initialising browser for kraken test... 06:13:44 INFO - TEST-INFO | started process 17105 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwmxwJZ/profile http://localhost:33199/getInfo.html) 06:13:48 INFO - PROCESS | 17105 | __metrics Screen width/height:1600/1200 06:13:48 INFO - PROCESS | 17105 | colorDepth:24 06:13:48 INFO - PROCESS | 17105 | Browser inner width/height: 1024/697 06:13:48 INFO - PROCESS | 17105 | __metrics 06:13:49 INFO - PROCESS | 17105 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:13:49 INFO - PROCESS | 17105 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:13:50 INFO - PROCESS | 17105 | console.error: PushService: 06:13:50 INFO - PROCESS | 17105 | stateChangeProcessEnqueue: Error transitioning state 06:13:50 INFO - PROCESS | 17105 | UnknownError 06:13:50 INFO - TEST-INFO | 17105: exit 0 06:13:50 INFO - Browser initialized. 06:13:50 INFO - Running cycle 1/1 for kraken test... 06:13:50 INFO - TEST-INFO | started process 17188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwmxwJZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:02 INFO - PROCESS | 17188 | RSS: Main: 178331648 06:14:02 INFO - PROCESS | 17188 | 06:14:05 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33199/tests/kraken/driver.html?testName=audio-beat-detection) 06:14:06 INFO - PROCESS | 17188 | RSS: Main: 236523520 06:14:06 INFO - PROCESS | 17188 | 06:14:08 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33199/tests/kraken/driver.html?testName=audio-dft) 06:14:09 INFO - PROCESS | 17188 | RSS: Main: 221290496 06:14:09 INFO - PROCESS | 17188 | 06:14:12 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33199/tests/kraken/driver.html?testName=audio-fft) 06:14:13 INFO - PROCESS | 17188 | RSS: Main: 302469120 06:14:13 INFO - PROCESS | 17188 | 06:14:15 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33199/tests/kraken/driver.html?testName=audio-oscillator) 06:14:15 INFO - PROCESS | 17188 | RSS: Main: 213389312 06:14:15 INFO - PROCESS | 17188 | 06:14:18 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33199/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:14:18 INFO - PROCESS | 17188 | RSS: Main: 216698880 06:14:18 INFO - PROCESS | 17188 | 06:14:21 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33199/tests/kraken/driver.html?testName=imaging-darkroom) 06:14:22 INFO - PROCESS | 17188 | RSS: Main: 252719104 06:14:22 INFO - PROCESS | 17188 | 06:14:25 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33199/tests/kraken/driver.html?testName=imaging-desaturate) 06:14:26 INFO - PROCESS | 17188 | RSS: Main: 251613184 06:14:26 INFO - PROCESS | 17188 | 06:14:29 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33199/tests/kraken/driver.html?testName=json-parse-financial) 06:14:29 INFO - PROCESS | 17188 | RSS: Main: 251281408 06:14:29 INFO - PROCESS | 17188 | 06:14:31 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33199/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:14:31 INFO - PROCESS | 17188 | RSS: Main: 214040576 06:14:31 INFO - PROCESS | 17188 | 06:14:33 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33199/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:14:34 INFO - PROCESS | 17188 | RSS: Main: 222089216 06:14:34 INFO - PROCESS | 17188 | 06:14:36 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33199/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:14:37 INFO - PROCESS | 17188 | RSS: Main: 222478336 06:14:37 INFO - PROCESS | 17188 | 06:14:39 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:14:40 INFO - PROCESS | 17188 | RSS: Main: 223526912 06:14:40 INFO - PROCESS | 17188 | 06:14:42 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:14:43 INFO - PROCESS | 17188 | RSS: Main: 222179328 06:14:43 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | Cycle 1(1): loaded http://localhost:33199/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33199/tests/kraken/driver.html?testName=ai-astar) 06:14:45 INFO - PROCESS | 17188 | RSS: Main: 273793024 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | __start_tp_report 06:14:45 INFO - PROCESS | 17188 | _x_x_mozilla_page_load 06:14:45 INFO - PROCESS | 17188 | _x_x_mozilla_page_load_details 06:14:45 INFO - PROCESS | 17188 | |i|pagename|runs| 06:14:45 INFO - PROCESS | 17188 | |0;ai-astar;109;112;113;112;113;113;114;113;113;113 06:14:45 INFO - PROCESS | 17188 | |1;audio-beat-detection;145;117;122;161;127;119;129;125;158;124 06:14:45 INFO - PROCESS | 17188 | |2;audio-dft;162;162;162;161;162;162;163;162;161;160 06:14:45 INFO - PROCESS | 17188 | |3;audio-fft;75;76;75;111;77;77;76;76;114;75 06:14:45 INFO - PROCESS | 17188 | |4;audio-oscillator;82;83;117;82;82;83;108;82;82;117 06:14:45 INFO - PROCESS | 17188 | |5;imaging-gaussian-blur;118;117;118;118;117;116;116;118;117;116 06:14:45 INFO - PROCESS | 17188 | |6;imaging-darkroom;147;147;146;147;147;146;145;146;145;146 06:14:45 INFO - PROCESS | 17188 | |7;imaging-desaturate;95;95;95;96;95;96;95;95;95;94 06:14:45 INFO - PROCESS | 17188 | |8;json-parse-financial;51;50;51;53;52;53;51;52;53;53 06:14:45 INFO - PROCESS | 17188 | |9;json-stringify-tinderbox;60;60;61;60;61;61;61;61;61;61 06:14:45 INFO - PROCESS | 17188 | |10;stanford-crypto-aes;80;81;79;84;79;87;80;79;79;88 06:14:45 INFO - PROCESS | 17188 | |11;stanford-crypto-ccm;124;127;125;135;131;125;123;123;171;124 06:14:45 INFO - PROCESS | 17188 | |12;stanford-crypto-pbkdf2;166;177;167;168;165;168;166;166;167;164 06:14:45 INFO - PROCESS | 17188 | |13;stanford-crypto-sha256-iterative;64;64;65;64;63;63;64;64;66;63 06:14:45 INFO - PROCESS | 17188 | __end_tp_report 06:14:45 INFO - PROCESS | 17188 | __start_cc_report 06:14:45 INFO - PROCESS | 17188 | _x_x_mozilla_cycle_collect,1677 06:14:45 INFO - PROCESS | 17188 | __end_cc_report 06:14:45 INFO - PROCESS | 17188 | __startTimestamp1474636485469__endTimestamp 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | ------- Summary: start ------- 06:14:45 INFO - PROCESS | 17188 | Number of tests: 14 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.35 (1.2%) stddev-sans-first:0.60 06:14:45 INFO - PROCESS | 17188 | Values: 109.0 112.0 113.0 112.0 113.0 113.0 114.0 113.0 113.0 113.0 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:128.00 stddev:16.06 (12.5%) stddev-sans-first:16.41 06:14:45 INFO - PROCESS | 17188 | Values: 145.0 117.0 122.0 161.0 127.0 119.0 129.0 125.0 158.0 124.0 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 06:14:45 INFO - PROCESS | 17188 | Values: 162.0 162.0 162.0 161.0 162.0 162.0 163.0 162.0 161.0 160.0 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:15.48 (20.4%) stddev-sans-first:16.13 06:14:45 INFO - PROCESS | 17188 | Values: 75.0 76.0 75.0 111.0 77.0 77.0 76.0 76.0 114.0 75.0 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:82.00 stddev:15.52 (18.9%) stddev-sans-first:16.05 06:14:45 INFO - PROCESS | 17188 | Values: 82.0 83.0 117.0 82.0 82.0 83.0 108.0 82.0 82.0 117.0 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.50 stddev:0.88 (0.7%) stddev-sans-first:0.87 06:14:45 INFO - PROCESS | 17188 | Values: 118.0 117.0 118.0 118.0 117.0 116.0 116.0 118.0 117.0 116.0 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 06:14:45 INFO - PROCESS | 17188 | Values: 147.0 147.0 146.0 147.0 147.0 146.0 145.0 146.0 145.0 146.0 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:14:45 INFO - PROCESS | 17188 | Values: 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 94.0 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.50 stddev:1.10 (2.1%) stddev-sans-first:1.12 06:14:45 INFO - PROCESS | 17188 | Values: 51.0 50.0 51.0 53.0 52.0 53.0 51.0 52.0 53.0 53.0 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 06:14:45 INFO - PROCESS | 17188 | Values: 60.0 60.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.50 stddev:3.47 (4.3%) stddev-sans-first:3.63 06:14:45 INFO - PROCESS | 17188 | Values: 80.0 81.0 79.0 84.0 79.0 87.0 80.0 79.0 79.0 88.0 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:126.00 stddev:14.64 (11.6%) stddev-sans-first:15.32 06:14:45 INFO - PROCESS | 17188 | Values: 124.0 127.0 125.0 135.0 131.0 125.0 123.0 123.0 171.0 124.0 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:167.00 stddev:3.60 (2.2%) stddev-sans-first:3.78 06:14:45 INFO - PROCESS | 17188 | Values: 166.0 177.0 167.0 168.0 165.0 168.0 166.0 166.0 167.0 164.0 06:14:45 INFO - PROCESS | 17188 | 06:14:45 INFO - PROCESS | 17188 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 06:14:45 INFO - PROCESS | 17188 | Values: 64.0 64.0 65.0 64.0 63.0 63.0 64.0 64.0 66.0 63.0 06:14:45 INFO - PROCESS | 17188 | -------- Summary: end -------- 06:14:45 INFO - PROCESS | 17188 | 06:14:46 INFO - TEST-INFO | 17188: exit 0 06:14:46 INFO - TEST-OK | kraken | took 62089ms 06:14:46 INFO - SUITE-END | took 1179s 06:14:47 INFO - Completed test suite (00:19:39) 06:14:47 INFO - javascript benchmark 06:14:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3022.319978004949, 3025.4705426550363, 3042.376312855865, 3051.832149231792, 3092.1032900458868, 5160.870978225546, 5206.297149884765, 5268.0, 5373.5701143908445, 5386.8922621547545, 5279.736013199335, 5293.68237905725, 5304.336957880265, 5311.814086506973, 5313.017091838013, 4817.22924332107, 4837.177679794443, 4851.563359297663, 4890.902181956377, 4959.528844759742, 4986.675866068712, 5026.673266237683, 5057.544820966113, 5089.821856235032, 5095.3376061112185, 4954.232094025432, 4969.080720066781, 5029.899402011957, 5033.169527028036, 5038.017586570621, 4875.780589873429, 5004.474530174352, 5010.899782004358, 5041.1682072458, 5084.110280700863, 4881.682690625098, 4902.093112774148, 4929.457759646436, 4971.975140124312, 5003.4746351633285, 5212.921806172911, 5312.840614781563, 5341.412444631087, 5390.110631745757, 5390.299261096072, 5620.606557540974, 5622.746976386032, 5623.128415095667, 5627.971860140714, 5631.1271752878365, 5685.175649530836, 5752.252207213078, 5760.654360738369, 5761.827145185651, 5776.913346299767, 5238.240455133984, 5265.86835329116, 5271.235670827708, 5311.28297679816, 5377.946220537784, 5735.541156707453, 5751.424857514216, 5761.164631128463, 5761.39505351932, 5824.534037277008, 5535.308086489189, 5547.33431988164, 5547.750351234205, 5550.944490555124, 5554.50009499147, 5586.13414920688, 5614.354349249807, 5635.549156067505, 5639.971800140973, 5726.141078838207, 5650.0959846424375, 5691.516221121168, 5711.885762284731, 5712.0860662293835, 5713.657180569179, 5726.0838265877255, 5728.369879313273, 5728.828135155952, 5730.598858079894, 5734.684592347461, 4397.890052748707, 4428.800703968329, 4429.977850110793, 4439.66702497314, 4443.2224360736745, 3928.43037759529, 3950.170464202492, 3960.2673505401594, 3974.7813870237414, 3995.0212198011673, 5443.618946673695, 5449.536789372948, 5451.454854514517, 5512.3660779010925, 5532.2531458253425, 5763.88472230553, 5772.567057470623, 5772.7113644317615, 5776.277965254343, 5783.739731712083, 5251.159814429673, 5279.287296214962, 5284.365876094893, 5446.128619420873, 5452.427495112956, 4958.876028099255, 4993.875153121128, 4994.625403094782, 5016.072026675077, 5081.517255860687, 5866.120081987736, 5874.148248504029, 5875.794347197913, 5884.941150588525, 5960.433758792908, 5618.353889302619, 5758.481736643722, 5759.712014399347, 5766.077427611562, 5794.739236734273, 5808.099744539603, 5901.29184497863, 5923.170756094237, 5941.67320797343, 6042.607230530001, 5685.51673107774, 5692.5445964321925, 5693.430656934273, 5703.429657034263, 5703.600747947604, 5792.3049234090495, 5795.39148389413, 5807.767689292381, 5809.50619197373, 5809.50619197373, 5481.0408178567795, 5537.975474537224, 5609.158626206102, 5664.631798933056, 5710.514606258348, 5576.302962129734, 5602.383737788921, 5610.102383618601, 5614.2701448811395, 5666.943330566642, 5577.051901176728, 5587.972060139673, 5588.189712491747, 5599.832005039855, 5605.691686957257, 5460.126379779216, 5514.393416724077, 5636.5208957237455, 5639.182318563868, 5668.858278543069, 5589.832305030855, 5594.580406469449, 5599.720013999202, 5659.830205093689, 5666.46168613981], "value": 5291.623314912254, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.1857251268123, 589.0281036290123, 599.0863932502936, 606.142308633284, 620.1442010026163, 30198.698013019864, 30768.846155769217, 41363.37954930678, 42269.0, 42270.15459690804, 39549.0, 43707.562924370744, 43795.0, 43809.0, 43857.34213986793, 8054.677812887478, 8869.024407315206, 9020.503872287021, 9023.819523609523, 9030.0, 7908.762737117896, 8271.421000529965, 8280.089190189074, 10410.531526081344, 10688.09151222147, 10870.72823179419, 10950.288231264982, 10952.123830093613, 11010.119190464744, 11022.118230541577, 10815.242932994694, 10842.891571084267, 10852.891471085268, 10878.782424351468, 10885.564577416893, 8024.919750802475, 8070.515769053875, 10289.176865850714, 10630.309029913109, 10641.57433702651, 41499.377509337384, 41717.37423938643, 41737.791311043555, 41766.79116604428, 41825.79087104545, 3394.6775056369606, 3439.570053743282, 3453.9481907771406, 3635.4001589737663, 3693.0028892199225, 31100.0, 31192.22019449532, 31656.0, 31720.0, 31751.04746857598, 4217.283061879488, 4338.652907767371, 4342.174986752539, 4556.658250631216, 4563.589276965089, 332245.0, 334391.0, 335441.0, 335453.32273338723, 335531.0, 55482.0, 55811.44188558144, 55823.76704931838, 55858.0, 55932.44067559273, 57909.71045144747, 58767.706161468916, 58956.705216474504, 59114.40885591089, 59172.11241831376, 14948.177850218124, 15249.695006099815, 15255.771163432557, 15257.237138143271, 15258.923705381623, 11531.596394126165, 11655.0, 11678.357690327113, 11681.76636467266, 11684.94157529224, 14138.858611413754, 14409.207493587954, 14411.92794036023, 14614.123152610877, 15545.611359716098, 6220.968895155585, 6362.236531616236, 6369.426751592379, 6455.289918109004, 6546.116274302908, 888.471359541072, 1006.9647562335283, 1019.9337043092323, 1052.026875140492, 1062.5431064642123, 30708.85822835442, 30795.846020769754, 30885.536716949264, 30887.536686949712, 31247.0, 1009.8737657792776, 1021.7241344836852, 1037.305005646219, 1073.3291692692067, 1085.3487907255583, 15373.615659608375, 16119.597010074607, 16202.594935126715, 16255.756163657554, 16496.67006659884, 483204.0, 489276.0, 489577.0, 490741.0, 493490.04159334337, 47889.0, 49227.26159107616, 50157.74921125371, 53851.19223211655, 55230.72384638131, 1302.2642207153117, 1305.9804102938463, 1344.7176093020576, 1345.7173993461483, 1362.2711849160848, 29482.262943426587, 31225.8438707805, 31355.84322078375, 31676.5248521277, 32312.35375292528, 47866.760666196446, 48303.75848120737, 48388.758056209495, 48500.0, 48596.514034860615, 444371.0, 454593.0, 454946.0, 668420.0, 669470.0, 26568.601470978338, 26708.332291692863, 26986.1904142876, 27097.322566935985, 27165.59251611267, 43132.0, 43654.56345436505, 44606.3309050358, 45207.773961129984, 45263.77368113138, 37221.627783721815, 37850.810745947194, 37989.0, 38232.0, 39515.40726889156, 37979.0, 38404.62335273008, 38778.80610596929, 38885.80557097196, 39184.608153918096, 36286.45570316395, 36440.27119457649, 37212.0, 37496.62503374931, 38090.61909380871, 32933.0, 34660.82669586636, 35116.29767404689, 35694.28611427705, 35776.10559736027, 25687.871560642077, 25747.0, 26210.606840897784, 26368.8681556591, 26640.467190656465], "value": 19490.159815937102, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.2700258978161, 380.42555740831335, 381.4621383848772, 389.696037091069, 397.58651002956924, 14375.137491750502, 18349.81650183498, 19067.713984290247, 19136.80863191371, 20290.89854550725, 17481.650366992653, 18447.72328415075, 18499.815001849976, 18676.159572819222, 18678.15948282327, 5554.444555544444, 5885.61743486672, 5892.410758924095, 5893.292804863422, 5893.911591326134, 4126.261823384456, 4253.553376895427, 5760.8271751847515, 5826.15520749491, 6462.159919210496, 6515.38103880133, 6535.771248006321, 6540.771073012422, 6543.1821022372205, 6546.541742078057, 6300.275468321133, 6507.642079685639, 6513.837154071139, 6525.314841941623, 6552.967235163794, 5759.107338362561, 5783.929972954975, 5785.074388097884, 5792.536597072266, 5795.391483894173, 22323.330300091024, 22760.77239227603, 22900.885495572584, 23007.769922300897, 23020.30939071814, 2449.497852940143, 2520.4877073755783, 2683.6645419322585, 2688.206978941217, 2974.092901664991, 14020.85979140216, 14259.429622815074, 14267.643308917257, 14391.2084835334, 14562.344694488667, 1783.7413575031678, 1880.0787614069145, 1898.905054747257, 1914.8372388347007, 1979.712941623471, 79283.0, 80150.0, 81786.59106704428, 82640.58679706624, 82961.3407731848, 10140.087392134743, 10205.489725513695, 10511.316764410289, 10534.315269507457, 10947.50736216872, 14693.118412895261, 14710.117392956457, 14711.632209194855, 14729.705405892037, 14735.92632036833, 7032.8945065824055, 7316.743913963092, 7421.332080112816, 7483.550986940692, 7530.322270995636, 7034.331738484836, 7040.331168538981, 7045.788626341116, 7301.342879140902, 7326.04761381017, 6418.8716225675225, 6449.290578036413, 6509.804705858832, 6513.804585862432, 6539.901901471481, 1778.1642627964836, 1813.9435051937528, 1830.8626852986079, 1849.426677729881, 1868.9813101869079, 936.7049379445452, 984.9458279794537, 1026.7484466305802, 1028.953697083618, 1093.2565855218368, 18856.15147318374, 19588.70616940747, 19665.311714089938, 19753.40739777809, 19992.60014799696, 930.6463543853292, 979.5787811241235, 996.2080146283722, 1002.6891663584312, 1036.08824234673, 10277.126444252322, 11089.780124186333, 11232.49453774582, 11276.830847537294, 11322.603708870314, 447247.0, 456516.0, 456518.0, 457698.0, 461333.0, 50007.49932506092, 84652.15347846565, 87074.0, 87119.0, 87183.0, 973.4354074636693, 1006.4615430744517, 1017.4404077757204, 1027.275770581738, 1038.7974345002804, 16651.916740416706, 16687.666246674755, 17393.217305221548, 17662.381816636356, 17993.73009404886, 40784.0, 40963.0, 41659.37510937278, 41754.582454176285, 42584.148317032865, 53464.198037030255, 54469.72765136149, 56744.432555675565, 57078.14382784344, 60951.69524152351, 8395.412321137463, 8849.115088491099, 8884.511351875708, 8891.088415990593, 8930.776730581787, 12487.375631218585, 13337.933310333387, 13372.866271337161, 13452.645786987434, 13498.865011350154, 10948.890511094787, 11167.609133680282, 11706.414679266172, 11750.118741094622, 11759.0, 11606.0, 11686.123540734308, 11723.179377443497, 11984.612398664438, 12016.399180041139, 11904.58333958342, 11996.0, 12107.273563586214, 12459.314737689514, 12517.436715347649, 8562.400631955703, 8642.78393040179, 8775.591730749871, 8956.820863582821, 9051.321150913576, 10785.382192670848, 11103.777924441627, 11435.485403156712, 11557.13321500874, 11763.823542646696], "value": 9311.682333658433, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.367866584707, 1463.9194844283563, 1504.8871334649903, 1638.4265507072525, 1789.0, 7757.961210193948, 8734.170253825892, 8950.104989501055, 8960.641574337018, 9177.944536378302, 8964.50695211763, 9031.864522032174, 9039.502827344493, 9051.72844814655, 9103.408278461895, 2298.6666933294705, 2317.582835089683, 2318.988405057981, 2324.790768830805, 2326.6510023496444, 2324.0239099578216, 2324.732655744586, 2372.063035101134, 2378.4767351182713, 2382.03527571333, 2315.1781117703226, 2319.7100362454694, 2326.813854891613, 2378.92863214103, 2380.9166679166233, 2284.383216531544, 2305.700258966332, 2317.1310758465575, 2319.976800231993, 2330.906763729449, 2263.309690544383, 2265.478939843845, 2277.806386457153, 2281.441046943493, 2286.7598902115205, 8913.732588022369, 8962.86555701665, 9020.458772473672, 9045.231155351803, 9153.54232288383, 5193.8961220775755, 5306.230596563515, 5325.041492531343, 5328.094223981893, 5329.413764485942, 3441.6558344165633, 3474.617792042873, 3518.4018716817945, 3538.841306802848, 3555.5911070227, 1203.5366383942157, 1206.1556910162922, 1213.308414203904, 1214.7934851075338, 1221.4686611324103, 12323.568675096418, 12453.0, 12477.563285284972, 12519.186252893533, 12522.74954500914, 4157.605027522381, 4376.365427013129, 4444.911101778011, 4469.150861336336, 4559.361689363492, 9844.0, 9863.408195508293, 9866.161376282953, 9883.406995580288, 9890.950545247228, 5124.077666020077, 5154.7164905929785, 5158.561522270574, 5163.225516172529, 5164.147915593885, 4174.7077704561, 4292.935605965913, 4675.625949923998, 4754.548317909793, 4774.21225497789, 3550.431930891045, 3704.3700771660383, 3712.7215458840697, 3752.4746535485056, 3754.5682246541996, 1140.321508702321, 1145.3700464744356, 1154.0536759857005, 1159.9594014209463, 1165.906727461801, 842.2293601354814, 915.6520522201521, 940.9952950235205, 941.764558860285, 973.5035132082688, 5931.13998470228, 5980.940190598125, 6078.270607527125, 6301.369863013662, 6392.744290228339, 941.5904081724472, 946.9289803264783, 977.1205914676848, 988.6935050134338, 1010.434156872154, 3979.880603581897, 4102.979485102555, 4118.45401407614, 4126.154138401621, 4181.954511372157, 10771.246012779187, 11077.556897724162, 11138.554457821596, 11152.386618735885, 11189.384583847966, 10991.06575941038, 11057.06014988719, 11118.722031949104, 11134.554617815358, 11142.554297828157, 8166.959165204136, 8173.100958894517, 8216.424850260544, 8249.876251856227, 8254.257116859511, 5589.916151257653, 5633.492985631313, 5775.711214439178, 5823.82528524145, 5939.218234529538, 10290.485475726035, 10295.0, 10307.433091180057, 10329.173666106542, 10352.223583231438, 9617.278704097082, 10035.397876127456, 10047.045530674573, 10123.493825308853, 10161.441120738431, 7129.536580122275, 7335.523190992569, 7734.961325193338, 7955.4828936118965, 8081.070676872235, 8464.322854171774, 8787.472751634923, 8799.428037177562, 8800.867986980073, 8810.823783524422, 7698.191689872483, 7708.845823083395, 7722.961385193038, 7893.289603935674, 8161.836763264821, 7836.490628109154, 7887.881681774663, 7903.1306556279915, 7930.444868859356, 8028.799280018046, 7164.749233776793, 7170.5647178888685, 7257.637118144177, 7261.818454538678, 7264.055672762507, 5113.488651135006, 5175.353080864892, 5189.065968125774, 5207.687538747536, 5366.731663416892, 4999.550040496373, 5066.417362003417, 5124.385073791169, 5180.860210753628, 5347.946520534745], "value": 4637.750050683261, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.845912421162, 336.6213010363341, 337.84290305008165, 342.6111363602314, 345.93081383723256, 5139.4346621871655, 5240.292560504331, 5292.470752924711, 5332.733363331832, 5342.545883599893, 5057.939946332471, 5149.249255253213, 5191.247269145972, 5233.502817232366, 5238.5023422774875, 4167.687423443239, 4174.08170202555, 4184.518780340261, 4190.769507677077, 4220.957790422102, 3954.5254569451704, 4042.615951484619, 4159.334506478964, 4185.0, 4191.455110835587, 4062.4312596236405, 4065.715399922007, 4072.7149099563044, 4074.0, 4082.122343696105, 4071.145059537501, 4073.918521629551, 4107.301758701028, 4121.732087414309, 4123.814428350702, 3640.1809592841664, 3651.6165802590876, 3653.1232504199065, 3665.0, 3673.8611030580605, 5104.923426148611, 5106.617003724736, 5128.282040514331, 5132.563732082777, 5134.204198349262, 4620.376249206348, 4651.093036857814, 4685.601723853477, 4708.399144290957, 4717.858464246044, 5468.7539060742365, 5471.534919531845, 5481.260029895953, 5503.670279480936, 5505.256790333294, 3756.812159392047, 3932.5674175840636, 3953.822078006468, 3962.9498182981533, 3978.2694527880462, 5624.634398764068, 5639.238702775114, 5657.60396772222, 5674.347450043216, 5675.971620141873, 4070.470838790938, 4082.1835632873544, 4100.2414553307735, 4111.835526578903, 4120.990357362465, 4046.1705350403686, 4074.246264441088, 4114.814833332507, 4122.474684366804, 4161.271777438936, 4619.514950930171, 4674.859754207379, 4675.392199014106, 4675.57919787214, 4688.929666055012, 5493.697846618475, 5498.670079795225, 5507.476789704971, 5536.4186760390385, 5562.833115006556, 1330.3281842669583, 1359.6464919120901, 1411.84469708332, 1416.4546649539795, 1420.3324437514352, 904.6291020681489, 919.5356345045843, 925.7731855695398, 940.6895724410928, 943.4103685196752, 4635.678831532997, 4657.672563319437, 4658.883527911829, 4665.906681866344, 4669.766511674471, 4849.515048495122, 4873.731944743002, 4902.877428064256, 4916.271469334553, 4972.453030166679, 4452.840372419374, 4637.25803871379, 4643.814247430132, 4644.767761611906, 4672.275797251432, 2611.6865976082613, 2627.9605805912925, 2632.6182703507884, 2634.0385759197757, 2641.5773476243708, 5045.0, 5065.797368105234, 5087.669301495391, 5102.285680004802, 5140.072472822691, 4811.831585894477, 4916.394311015168, 5071.518205770446, 5073.188289873677, 5078.181609206852, 5013.924791128136, 5038.924416133761, 5053.852112852023, 5066.670666406671, 5067.0, 4916.385451818523, 4934.3585333907795, 4941.481144479922, 4946.1591529439365, 4949.97525012387, 4625.0, 4876.95123048765, 4879.414470263591, 4944.332515110558, 4957.033378491304, 5052.5705315048635, 5052.823151189691, 5082.440931497458, 5106.66806657566, 5122.359705036871, 3690.9146332323226, 3718.925621487609, 3726.0, 3773.52830896138, 3779.640934111255, 5019.799208031638, 5036.118679231046, 5046.949530504795, 5068.746562671778, 5511.338639363302, 5553.972230138824, 5560.4161563035295, 5590.496855283044, 5648.5763567731765, 5661.094224923992, 5570.6657600544095, 5576.637518561281, 5590.496855283044, 5592.832215033555, 5663.575231857545, 5289.497497737709, 5515.944840551543, 5542.61201715876, 5620.6393314807065, 5631.493165615114, 5530.198121272473, 5580.888382232414, 5582.246396736551, 5596.468335508121, 5611.551075913835, 5502.504774570308, 5552.0, 5554.528234935577, 5555.805546805843, 5558.138488534284], "value": 4043.991039303719, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.5793565924785, 725.713343229424, 735.8146305472744, 795.9960200198998, 842.2546046748628, 16175.757363639541, 17049.403270885523, 17097.743533847002, 17115.40096096637, 17119.914400427995, 14636.195009274512, 14926.925365373158, 15079.0, 15149.091054536708, 15174.393024279016, 779.0223269796426, 781.1914668318292, 785.83104632504, 786.3041208530434, 787.3897729259841, 652.6508318049845, 660.4155322539563, 767.2212704105337, 775.170567492783, 778.3889646627399, 825.413956091173, 833.2459124492314, 836.067784420373, 842.9452085614446, 843.0726201178716, 806.3267171911461, 811.3387589114852, 812.0417906869891, 812.1472453923357, 815.0789607743242, 508.0905179728282, 509.617786660005, 592.7688201601379, 592.9347771745105, 595.6991719181785, 14464.783028254584, 14736.484223052248, 14781.704365912728, 15355.616109597238, 15374.615634609112, 14375.424983000667, 14732.779008314883, 15310.846891531053, 15445.922770386076, 15665.765013524806, 11953.760924781456, 11960.282383057045, 12003.819942700778, 12233.694157646041, 12249.816252756216, 3779.3764028935193, 3854.2869569129803, 3860.645006546005, 4026.697997650188, 4026.879193624196, 82191.5890420544, 82869.58565207195, 84056.0, 84332.57833710792, 84849.57575212145, 10813.945930270298, 11109.44452777358, 11220.943895280472, 11235.213535052468, 11531.654050378502, 21681.783182167976, 22466.32601021972, 23519.294421167393, 23578.646320305208, 23624.527509449716, 8294.631385821393, 8304.916950830535, 8417.158284171534, 8529.44116764968, 8695.695650652196, 4667.883302917454, 4727.267273572602, 4729.172394830891, 4824.107540105092, 4835.709857408497, 3441.552598162273, 3551.751377403609, 3553.6446355364255, 3553.8400771965325, 3557.4130268505924, 591.7455494137477, 598.0789584040529, 606.3178923710825, 612.087988896541, 612.5650787940613, 619.9987020961115, 638.8530637953297, 649.9350064993557, 671.4785978650235, 697.5500801982794, 9014.774630634287, 9378.5310734463, 9470.431774093577, 9626.855597166048, 9922.751931201778, 665.2017578905333, 665.8668266346654, 683.282553319013, 699.762080892499, 699.7935608995358, 4569.634429245652, 4668.416447944007, 4781.11549363362, 4787.49145625356, 4800.0, 113747.0, 126040.0, 128172.0, 130812.0, 132589.0, 104713.0, 107276.46361768141, 108285.45857270663, 108950.0, 112056.0, 90975.54512227396, 93742.5312873445, 96196.51901740587, 96653.50197470436, 99441.0, 8680.479171249744, 8955.641774328953, 9060.411073280216, 9094.181523662637, 9095.317851161322, 52582.73708631585, 53096.0, 53503.46496534985, 55021.724891375285, 55291.72354138204, 45329.546704532535, 46082.0, 48612.75693621509, 77869.61065194638, 81407.0, 10901.454927253764, 11368.033717134136, 11510.36692981894, 11870.406479675808, 11936.58221962227, 13506.932465338003, 14161.291935403395, 14541.927290363481, 15043.924780376028, 15126.621834454227, 13782.724345512834, 14318.928405357907, 14584.052036617586, 14626.926865365605, 15212.391504339703, 14335.641608959859, 14349.856501434851, 14687.24193853292, 14880.702385952436, 15009.699806004037, 13079.869201307865, 13797.586072417844, 13941.163530187816, 13993.440262389391, 14115.435382584581, 10301.9484902575, 10563.947180264357, 11657.300561966309, 11786.351750653796, 11903.345316007702, 9896.653617123366, 10144.340617859816, 11189.272697274977, 11272.210945234083, 11531.596394126165], "value": 7532.2237919107865, "unit": "score"}], "name": "dromaeo_css", "value": 7168.361462472354, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 113.0, 112.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 122.0, 161.0, 127.0, 119.0, 129.0, 125.0, 158.0, 124.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 163.0, 162.0, 161.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 111.0, 77.0, 77.0, 76.0, 76.0, 114.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 117.0, 82.0, 82.0, 83.0, 108.0, 82.0, 82.0, 117.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 116.0, 116.0, 118.0, 117.0, 116.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 51.0, 53.0, 52.0, 53.0, 51.0, 52.0, 53.0, 53.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 84.0, 79.0, 87.0, 80.0, 79.0, 79.0, 88.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 127.0, 125.0, 135.0, 131.0, 125.0, 123.0, 123.0, 171.0, 124.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 177.0, 167.0, 168.0, 165.0, 168.0, 166.0, 166.0, 167.0, 164.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 63.0, 63.0, 64.0, 64.0, 66.0, 63.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1496.7, "alertThreshold": 2.0}]} 06:14:47 INFO - Return code: 0 06:14:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:14:47 INFO - # TBPL SUCCESS # 06:14:47 INFO - Running post-action listener: _resource_record_post_action 06:14:47 INFO - [mozharness: 2016-09-23 13:14:47.257543Z] Finished run-tests step (success) 06:14:47 INFO - Running post-run listener: _resource_record_post_run 06:14:47 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403804160; Read time: 20; Write time: 251436 06:14:47 INFO - TinderboxPrint: CPU usage
13.1% 06:14:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 06:14:47 INFO - TinderboxPrint: I/O write bytes / time
403,804,160 / 251,436 06:14:47 INFO - TinderboxPrint: CPU idle
8,302.2 (86.9%) 06:14:47 INFO - TinderboxPrint: CPU user
1,203.8 (12.6%) 06:14:47 INFO - TinderboxPrint: Swap in / out
0 / 0 06:14:47 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 115265536; Read time: 0; Write time: 51284 06:14:47 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288133120; Read time: 20; Write time: 200052 06:14:47 INFO - Running post-run listener: _upload_blobber_files 06:14:47 INFO - Blob upload gear active. 06:14:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:14:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:14:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:14:48 INFO - (blobuploader) - INFO - Open directory for files ... 06:14:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:14:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:14:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:49 INFO - (blobuploader) - INFO - Done attempting. 06:14:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:14:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:14:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:52 INFO - (blobuploader) - INFO - Done attempting. 06:14:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:14:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:14:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:53 INFO - (blobuploader) - INFO - Done attempting. 06:14:53 INFO - (blobuploader) - INFO - Iteration through files over. 06:14:53 INFO - Return code: 0 06:14:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:14:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:14:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4410ec68af4f896582ab89abcd0ba821ebad1f4a4a4c4ff4ba5d5cee3cc3184a2a5773f4ca10c116b4ed8fb1f5cf1222e5abda874ec7d3d2cccf71ec1924040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e6def442d87141ab37a8b108f1a39cb2d9457e961656b2971bdddc41f479bebf9f1d42f3d53a4f31982fbed32795f07073105eb1ed056ec3fa5a714bd12d908", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/708ed1209cbac426e6b8fb9583349b33d54e526fc148c612a51fa2f8a0e66c4861a8ef3ef2e98f4df2163735391e9fecf37da74b21ae271dffb62da845de3d33"} 06:14:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:14:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:14:53 INFO - Contents: 06:14:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4410ec68af4f896582ab89abcd0ba821ebad1f4a4a4c4ff4ba5d5cee3cc3184a2a5773f4ca10c116b4ed8fb1f5cf1222e5abda874ec7d3d2cccf71ec1924040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e6def442d87141ab37a8b108f1a39cb2d9457e961656b2971bdddc41f479bebf9f1d42f3d53a4f31982fbed32795f07073105eb1ed056ec3fa5a714bd12d908", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/708ed1209cbac426e6b8fb9583349b33d54e526fc148c612a51fa2f8a0e66c4861a8ef3ef2e98f4df2163735391e9fecf37da74b21ae271dffb62da845de3d33"} 06:14:53 INFO - Running post-run listener: copy_logs_to_upload_dir 06:14:53 INFO - Copying logs to upload dir... 06:14:53 INFO - mkdir: /builds/slave/test/build/upload/logs 06:14:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.154705 ========= master_lag: 0.55 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-23 06:14:53.110900) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 06:14:53.114095) ========= 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=cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4410ec68af4f896582ab89abcd0ba821ebad1f4a4a4c4ff4ba5d5cee3cc3184a2a5773f4ca10c116b4ed8fb1f5cf1222e5abda874ec7d3d2cccf71ec1924040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e6def442d87141ab37a8b108f1a39cb2d9457e961656b2971bdddc41f479bebf9f1d42f3d53a4f31982fbed32795f07073105eb1ed056ec3fa5a714bd12d908", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/708ed1209cbac426e6b8fb9583349b33d54e526fc148c612a51fa2f8a0e66c4861a8ef3ef2e98f4df2163735391e9fecf37da74b21ae271dffb62da845de3d33"} build_url:https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/MvWZesrsSB6dnj0ZT0l4fw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4410ec68af4f896582ab89abcd0ba821ebad1f4a4a4c4ff4ba5d5cee3cc3184a2a5773f4ca10c116b4ed8fb1f5cf1222e5abda874ec7d3d2cccf71ec1924040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e6def442d87141ab37a8b108f1a39cb2d9457e961656b2971bdddc41f479bebf9f1d42f3d53a4f31982fbed32795f07073105eb1ed056ec3fa5a714bd12d908", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/708ed1209cbac426e6b8fb9583349b33d54e526fc148c612a51fa2f8a0e66c4861a8ef3ef2e98f4df2163735391e9fecf37da74b21ae271dffb62da845de3d33"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 06:14:53.139576) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:14:53.139939) ========= 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=cbe409c6de289db6ac707de3000001d4-1474634228.947207-73241720 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:14:53.290092) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 06:14:53.290461) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 06:14:53.460697) ========= ========= Total master_lag: 0.78 =========